niks3-go-unit-tests
checks.aarch64-linux.go-unit-tests
· build #462
· raw
1tribuchet: building on eliza2Running client tests...3=== RUN TestDoServerRequestAttachesToken4=== PAUSE TestDoServerRequestAttachesToken5=== RUN TestUploadBuildLog_FileBodyReplayedOnRetry6=== PAUSE TestUploadBuildLog_FileBodyReplayedOnRetry7=== RUN TestRegisterUploadedObjectReusesConnections8=== PAUSE TestRegisterUploadedObjectReusesConnections9=== RUN TestRunGarbageCollection_FinishedOnAnotherReplica10=== PAUSE TestRunGarbageCollection_FinishedOnAnotherReplica11=== RUN TestRunGarbageCollection_NotFoundAfterLocalRun12=== PAUSE TestRunGarbageCollection_NotFoundAfterLocalRun13=== RUN TestCaseHackSuffix14=== PAUSE TestCaseHackSuffix15=== RUN TestFilterOversizedClosures16=== PAUSE TestFilterOversizedClosures17=== RUN TestUploadMultipart_PartsInParallel18=== PAUSE TestUploadMultipart_PartsInParallel19=== RUN TestUploadMultipart_FailedPartBufferNotReused20=== PAUSE TestUploadMultipart_FailedPartBufferNotReused21=== RUN TestPartSizeForNAR22=== PAUSE TestPartSizeForNAR23=== RUN TestUploadMultipart_SupersededByPeer24=== PAUSE TestUploadMultipart_SupersededByPeer25=== RUN TestDumpPathCaseHackMatchesNix26--- PASS: TestDumpPathCaseHackMatchesNix (2.61s)27=== RUN TestDumpPathCaseHackCollision28--- PASS: TestDumpPathCaseHackCollision (0.00s)29=== RUN TestSupersededNARStillUploadsListing30=== PAUSE TestSupersededNARStillUploadsListing31=== RUN TestDumpPathMatchesNix32=== PAUSE TestDumpPathMatchesNix33=== RUN TestDumpPathSingleFile34=== PAUSE TestDumpPathSingleFile35=== RUN TestDumpPathWriterError36=== PAUSE TestDumpPathWriterError37=== RUN TestEncodeNixBase3238=== PAUSE TestEncodeNixBase3239=== RUN TestEncodeNixBase32WithRealHash40=== PAUSE TestEncodeNixBase32WithRealHash41=== RUN TestConvertHashToNix3242=== PAUSE TestConvertHashToNix3243=== RUN TestGetStorePathHash44=== PAUSE TestGetStorePathHash45=== RUN TestPathInfoHashCompatibility46=== PAUSE TestPathInfoHashCompatibility47=== RUN TestParsePathInfoJSON48=== PAUSE TestParsePathInfoJSON49=== RUN TestParsePathInfoJSONMultiplePaths50=== PAUSE TestParsePathInfoJSONMultiplePaths51=== RUN TestPathInfoCACompatibility52=== PAUSE TestPathInfoCACompatibility53=== RUN TestRateLimiterFeedback54=== PAUSE TestRateLimiterFeedback55=== RUN TestRateLimiterFeedback_400DoesNotCountAsSuccess56=== PAUSE TestRateLimiterFeedback_400DoesNotCountAsSuccess57=== RUN TestRegisterUploadedObject_BoundedAgainstSilentServer58=== PAUSE TestRegisterUploadedObject_BoundedAgainstSilentServer59=== 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=== CONT TestDoServerRequestAttachesToken116=== CONT TestDoWithRetry_BodyReplayedViaGetBody117=== CONT TestDumpPathWriterError118=== CONT TestScriptTokenScriptFails119=== CONT TestScriptTokenEmptyCommand120=== CONT TestStreamPushStopsWhenCanceled121--- PASS: TestScriptTokenEmptyCommand (0.00s)122=== CONT TestDumpPathSingleFile123=== CONT TestDumpPathMatchesNix124--- PASS: TestStreamPushStopsWhenCanceled (0.00s)125=== CONT TestResolveStorePath126--- PASS: TestResolveStorePath (0.00s)127=== CONT TestRegisterUploadedObject_BoundedAgainstSilentServer128--- PASS: TestScriptTokenScriptFails (3.06s)129=== CONT TestRateLimiterFeedback_400DoesNotCountAsSuccess130=== CONT TestSupersededNARStillUploadsListing131=== RUN TestSupersededNARStillUploadsListing/small_NAR132=== PAUSE TestSupersededNARStillUploadsListing/small_NAR133=== RUN TestSupersededNARStillUploadsListing/dump_cut_short134=== PAUSE TestSupersededNARStillUploadsListing/dump_cut_short135=== RUN TestSupersededNARStillUploadsListing/listing_upload_fails136=== PAUSE TestSupersededNARStillUploadsListing/listing_upload_fails137=== CONT TestUploadMultipart_SupersededByPeer138=== RUN TestUploadMultipart_SupersededByPeer/exists139=== PAUSE TestUploadMultipart_SupersededByPeer/exists140=== RUN TestUploadMultipart_SupersededByPeer/missing141=== CONT TestRateLimiterFeedback142=== RUN TestRateLimiterFeedback/429_enables_limiter143=== PAUSE TestRateLimiterFeedback/429_enables_limiter144=== RUN TestRateLimiterFeedback/503_enables_limiter145=== PAUSE TestRateLimiterFeedback/503_enables_limiter146=== RUN TestRateLimiterFeedback/200_does_not_enable_limiter147=== PAUSE TestRateLimiterFeedback/200_does_not_enable_limiter148=== RUN TestRateLimiterFeedback/400_does_not_enable_limiter149=== PAUSE TestRateLimiterFeedback/400_does_not_enable_limiter150=== PAUSE TestUploadMultipart_SupersededByPeer/missing151=== CONT TestPathInfoCACompatibility152=== RUN TestPathInfoCACompatibility/null_ca_field153=== PAUSE TestPathInfoCACompatibility/null_ca_field154=== RUN TestPathInfoCACompatibility/old_string_format_-_text155=== PAUSE TestPathInfoCACompatibility/old_string_format_-_text156=== RUN TestPathInfoCACompatibility/old_string_format_-_fixed_recursive157=== PAUSE TestPathInfoCACompatibility/old_string_format_-_fixed_recursive158=== RUN TestPathInfoCACompatibility/new_structured_format_-_text159=== CONT TestSetClientTLSErrors1602026/11/06 06:58:03 WARN Rate limiter enabled after throttle name=server-test rate=5161=== PAUSE TestPathInfoCACompatibility/new_structured_format_-_text162=== RUN TestPathInfoCACompatibility/new_structured_format_-_nar_method163=== PAUSE TestPathInfoCACompatibility/new_structured_format_-_nar_method164=== CONT TestUploadMultipart_PartsInParallel165=== CONT TestFileTokenReadsAndCaches166=== CONT TestRunGarbageCollection_NotFoundAfterLocalRun167=== CONT TestFilterOversizedClosures168=== RUN TestFilterOversizedClosures/no_limit_keeps_everything169=== PAUSE TestFilterOversizedClosures/no_limit_keeps_everything170=== RUN TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped171=== PAUSE TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped172=== RUN TestFilterOversizedClosures/all_closures_skipped173=== PAUSE TestFilterOversizedClosures/all_closures_skipped174=== CONT TestCaseHackSuffix175--- PASS: TestFileTokenReadsAndCaches (0.00s)176=== CONT TestGetStorePathHash177=== RUN TestGetStorePathHash/valid_store_path178=== PAUSE TestGetStorePathHash/valid_store_path179=== RUN TestGetStorePathHash/basename_without_hyphen_should_error180=== PAUSE TestGetStorePathHash/basename_without_hyphen_should_error181=== RUN TestGetStorePathHash/hash_with_invalid_characters_should_error182=== PAUSE TestGetStorePathHash/hash_with_invalid_characters_should_error183=== RUN TestGetStorePathHash/hash_with_wrong_length_should_error184=== PAUSE TestGetStorePathHash/hash_with_wrong_length_should_error185=== CONT TestParsePathInfoJSON186=== RUN TestParsePathInfoJSON/Nix_format187=== PAUSE TestParsePathInfoJSON/Nix_format188=== RUN TestParsePathInfoJSON/Lix_format189=== PAUSE TestParsePathInfoJSON/Lix_format190=== RUN TestParsePathInfoJSON/empty_input191=== PAUSE TestParsePathInfoJSON/empty_input192=== RUN TestParsePathInfoJSON/whitespace_only193=== PAUSE TestParsePathInfoJSON/whitespace_only194=== RUN TestParsePathInfoJSON/invalid_JSON195=== PAUSE TestParsePathInfoJSON/invalid_JSON196=== CONT TestPathInfoHashCompatibility197=== RUN TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)198=== PAUSE TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)199=== RUN TestPathInfoHashCompatibility/old_string_format_with_colon200=== PAUSE TestPathInfoHashCompatibility/old_string_format_with_colon201=== CONT TestStaticToken202--- PASS: TestStaticToken (0.00s)203=== CONT TestSetClientTLSDoesNotMutateDefaultTransport204=== RUN TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI205=== PAUSE TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI206=== RUN TestPathInfoHashCompatibility/new_structured_format_with_sha512207=== PAUSE TestPathInfoHashCompatibility/new_structured_format_with_sha512208=== CONT TestStreamPushIsolatesFailures209=== CONT TestRunGarbageCollection_FinishedOnAnotherReplica210=== CONT TestFileTokenMissing211=== CONT TestScriptTokenBadJSON212--- PASS: TestFileTokenMissing (0.00s)213=== CONT TestClientSignaturesByStorePath214--- PASS: TestClientSignaturesByStorePath (0.00s)215=== CONT TestStreamPushReportsSkippedPaths216--- PASS: TestStreamPushReportsSkippedPaths (0.00s)217=== CONT TestStreamPushReportsSignatures2182026/11/06 06:58:03 ERROR Upload failed error="bad path" count=3219--- PASS: TestStreamPushIsolatesFailures (0.03s)220=== CONT TestStreamPushRequestLine2212026/11/06 06:58:03 ERROR Upload failed error=boom count=1222--- PASS: TestStreamPushReportsSignatures (0.00s)223=== CONT TestStreamPushGivesUpOnDeadServer2242026/11/06 06:58:03 ERROR Upload failed error="connection refused" count=202252026/11/06 06:58:03 ERROR Server seems unavailable, giving up on batch untried=17226=== CONT TestScriptTokenEmptyToken227--- PASS: TestStreamPushGivesUpOnDeadServer (0.00s)228=== CONT TestEncodeNixBase32WithRealHash229--- PASS: TestEncodeNixBase32WithRealHash (0.00s)230=== CONT TestConvertHashToNix322312026/11/06 06:58:03 ERROR Upload failed error=boom count=1232=== RUN TestConvertHashToNix32/SRI_format_to_Nix32233=== PAUSE TestConvertHashToNix32/SRI_format_to_Nix32234=== RUN TestConvertHashToNix32/already_Nix32_format235=== PAUSE TestConvertHashToNix32/already_Nix32_format236=== RUN TestConvertHashToNix32/invalid_format237=== PAUSE TestConvertHashToNix32/invalid_format238=== CONT TestSetClientTLS239=== CONT TestScriptTokenCachesUntilRefresh240=== CONT TestScriptTokenNoExpiryRerunsEveryCall2412026/11/06 06:58:03 INFO Garbage collection started242=== RUN TestSetClientTLSErrors/missing_cert_file243=== PAUSE TestSetClientTLSErrors/missing_cert_file244=== RUN TestSetClientTLSErrors/missing_key_file245=== PAUSE TestSetClientTLSErrors/missing_key_file246=== RUN TestSetClientTLSErrors/missing_ca_file247=== PAUSE TestSetClientTLSErrors/missing_ca_file248=== RUN TestSetClientTLSErrors/invalid_ca_file249=== PAUSE TestSetClientTLSErrors/invalid_ca_file250=== CONT TestEncodeNixBase32251=== RUN TestEncodeNixBase32/test_string_hash252=== PAUSE TestEncodeNixBase32/test_string_hash253=== RUN TestEncodeNixBase32/empty_input254=== PAUSE TestEncodeNixBase32/empty_input255=== CONT TestUploadBuildLog_FileBodyReplayedOnRetry256=== CONT TestFileTokenEmpty257--- PASS: TestDoServerRequestAttachesToken (3.10s)258=== CONT TestShellSplitErrors259--- PASS: TestShellSplitErrors (0.00s)260--- PASS: TestSetClientTLSDoesNotMutateDefaultTransport (0.03s)261=== CONT TestStreamPushBatchesUnderLoad2622026/11/06 06:58:03 INFO Garbage collection started263=== CONT TestParsePathInfoJSONMultiplePaths264--- PASS: TestFileTokenEmpty (0.00s)265=== RUN TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths266=== PAUSE TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths267=== CONT TestStreamPushReportsEveryPath268=== CONT TestDoWithRetry_FinalResponseBodyReadable269=== CONT TestPartSizeForNAR270--- PASS: TestStreamPushReportsEveryPath (0.00s)271=== RUN TestPartSizeForNAR/zero_stays_at_minimum272=== CONT TestShellSplit273=== RUN TestStreamPushBatchesUnderLoad/oneAtATime=false274=== PAUSE TestStreamPushBatchesUnderLoad/oneAtATime=false275=== RUN TestStreamPushBatchesUnderLoad/oneAtATime=true276=== RUN TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths277=== PAUSE TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths278=== CONT TestUploadMultipart_FailedPartBufferNotReused279=== CONT TestSupersededNARStillUploadsListing/small_NAR280--- PASS: TestRunGarbageCollection_NotFoundAfterLocalRun (0.04s)2812026/11/06 06:58:03 INFO Uploading abc-hello (1.0GB)282--- PASS: TestShellSplit (0.00s)283=== PAUSE TestPartSizeForNAR/zero_stays_at_minimum284=== RUN TestPartSizeForNAR/small_stays_at_minimum285=== PAUSE TestPartSizeForNAR/small_stays_at_minimum286=== RUN TestPartSizeForNAR/80_GiB_fits_at_minimum287=== PAUSE TestPartSizeForNAR/80_GiB_fits_at_minimum288=== RUN TestPartSizeForNAR/115_GiB_needs_larger_parts289=== PAUSE TestPartSizeForNAR/115_GiB_needs_larger_parts290=== RUN TestPartSizeForNAR/1_TiB291=== PAUSE TestPartSizeForNAR/1_TiB292=== CONT TestRegisterUploadedObjectReusesConnections2932026/11/06 06:58:03 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=0294=== CONT TestRetryTimeoutOutlastsMaxRetries295=== PAUSE TestStreamPushBatchesUnderLoad/oneAtATime=true296=== CONT TestSupersededNARStillUploadsListing/dump_cut_short2972026/11/06 06:58:03 WARN Rate limiter enabled after throttle name=server-test rate=5298=== CONT TestSupersededNARStillUploadsListing/listing_upload_fails299=== RUN TestPartSizeForNAR/5_TiB_S3_max_object3002026/11/06 06:58:03 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:350473012026/11/06 06:58:05 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:43539/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:43539/api/uploads/complete3022026/11/06 06:58:05 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"303=== RUN TestSetClientTLS/rejects_connection_without_client_cert304=== PAUSE TestSetClientTLS/rejects_connection_without_client_cert305=== RUN TestSetClientTLS/succeeds_with_client_cert_and_CA306=== PAUSE TestSetClientTLS/succeeds_with_client_cert_and_CA307=== RUN TestSetClientTLS/preserves_debug_logging_transport308=== PAUSE TestSetClientTLS/preserves_debug_logging_transport3092026/11/06 06:58:05 WARN Rate limiter enabled after throttle name=server-test rate=53102026/11/06 06:58:05 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:411913112026/11/06 06:58:05 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:43539/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:43539/api/uploads/complete312=== PAUSE TestPartSizeForNAR/5_TiB_S3_max_object3132026/11/06 06:58:05 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"314=== RUN TestPartSizeForNAR/capped_at_5_GiB3152026/11/06 06:58:05 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:43539/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:43539/api/uploads/complete316=== PAUSE TestPartSizeForNAR/capped_at_5_GiB3172026/11/06 06:58:05 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"318=== CONT TestRateLimiterFeedback/429_enables_limiter3192026/11/06 06:58:05 WARN Rate limiter backed off name=server-test rate=5320--- PASS: TestRegisterUploadedObject_BoundedAgainstSilentServer (5.27s)321=== CONT TestUploadMultipart_SupersededByPeer/exists322--- PASS: TestDumpPathSingleFile (5.28s)323=== CONT TestRateLimiterFeedback/400_does_not_enable_limiter324--- PASS: TestDoWithRetry_FinalResponseBodyReadable (2.18s)325=== CONT TestRateLimiterFeedback/200_does_not_enable_limiter326=== CONT TestRateLimiterFeedback/503_enables_limiter3272026/11/06 06:58:05 WARN Rate limiter enabled after throttle name=server-test rate=53282026/11/06 06:58:05 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=429 url=http://127.0.0.1:420273292026/11/06 06:58:05 WARN Request returned retryable status, retrying attempt=1 backoff=1ms status=502 url=http://127.0.0.1:38965330--- PASS: TestScriptTokenCachesUntilRefresh (2.50s)331=== CONT TestUploadMultipart_SupersededByPeer/missing332--- PASS: TestScriptTokenBadJSON (2.50s)333=== CONT TestPathInfoCACompatibility/null_ca_field334--- PASS: TestScriptTokenNoExpiryRerunsEveryCall (2.50s)335=== CONT TestPathInfoCACompatibility/new_structured_format_-_nar_method336=== CONT TestPathInfoCACompatibility/new_structured_format_-_text3372026/11/06 06:58:05 INFO Uploading abc-hello (1.0GB)338=== CONT TestPathInfoCACompatibility/old_string_format_-_text339=== CONT TestPathInfoCACompatibility/old_string_format_-_fixed_recursive340--- PASS: TestPathInfoCACompatibility (0.00s)341 --- PASS: TestPathInfoCACompatibility/null_ca_field (0.00s)342 --- PASS: TestPathInfoCACompatibility/new_structured_format_-_nar_method (0.00s)343 --- PASS: TestPathInfoCACompatibility/new_structured_format_-_text (0.00s)344 --- PASS: TestPathInfoCACompatibility/old_string_format_-_text (0.00s)345 --- PASS: TestPathInfoCACompatibility/old_string_format_-_fixed_recursive (0.00s)346=== CONT TestGetStorePathHash/valid_store_path347=== CONT TestParsePathInfoJSON/Nix_format348=== CONT TestFilterOversizedClosures/no_limit_keeps_everything349=== CONT TestGetStorePathHash/hash_with_wrong_length_should_error350=== CONT TestGetStorePathHash/hash_with_invalid_characters_should_error3512026/11/06 06:58:05 INFO Uploading abc-hello (1.0GB)352--- PASS: TestStreamPushRequestLine (6.54s)353=== CONT TestGetStorePathHash/basename_without_hyphen_should_error354=== CONT TestParsePathInfoJSON/invalid_JSON355=== CONT TestParsePathInfoJSON/whitespace_only356=== CONT TestParsePathInfoJSON/empty_input357=== CONT TestParsePathInfoJSON/Lix_format3582026/11/06 06:58:09 WARN Garbage collection finished on another replica. Its statistics are not available here359--- PASS: TestRunGarbageCollection_FinishedOnAnotherReplica (6.71s)3602026/11/06 06:58:09 WARN Rate limiter backed off name=server-test rate=5361=== CONT TestFilterOversizedClosures/all_closures_skipped3622026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=2 backoff=0s status=503 url=http://127.0.0.1:411913632026/11/06 06:58:09 WARN Rate limiter enabled after throttle name=server-test rate=53642026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:366153652026/11/06 06:58:09 WARN Rate limiter backed off name=server-test rate=53662026/11/06 06:58:09 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=50367=== CONT TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped368=== CONT TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)3692026/11/06 06:58:09 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=2000370=== CONT TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI371=== CONT TestPathInfoHashCompatibility/new_structured_format_with_sha512372=== CONT TestPathInfoHashCompatibility/old_string_format_with_colon373=== CONT TestConvertHashToNix32/SRI_format_to_Nix32374--- PASS: TestScriptTokenEmptyToken (6.71s)375=== CONT TestConvertHashToNix32/invalid_format376=== CONT TestConvertHashToNix32/already_Nix32_format3772026/11/06 06:58:09 WARN Rate limiter backed off name=server-test rate=5378=== CONT TestSetClientTLSErrors/missing_cert_file379=== CONT TestSetClientTLSErrors/missing_ca_file380=== CONT TestSetClientTLSErrors/invalid_ca_file381=== CONT TestSetClientTLSErrors/missing_key_file382=== CONT TestEncodeNixBase32/test_string_hash383--- PASS: TestDoWithRetry_BodyReplayedViaGetBody (9.81s)384=== CONT TestEncodeNixBase32/empty_input385=== CONT TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths386=== CONT TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths387--- PASS: TestFilterOversizedClosures (0.00s)388 --- PASS: TestFilterOversizedClosures/all_closures_skipped (0.00s)389 --- PASS: TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped (0.00s)390 --- PASS: TestFilterOversizedClosures/no_limit_keeps_everything (0.00s)391=== CONT TestStreamPushBatchesUnderLoad/oneAtATime=false392--- PASS: TestGetStorePathHash (0.00s)393 --- PASS: TestGetStorePathHash/valid_store_path (0.00s)394 --- PASS: TestGetStorePathHash/hash_with_wrong_length_should_error (0.00s)395 --- PASS: TestGetStorePathHash/basename_without_hyphen_should_error (0.00s)396 --- PASS: TestGetStorePathHash/hash_with_invalid_characters_should_error (0.00s)397--- PASS: TestParsePathInfoJSON (0.00s)398 --- PASS: TestParsePathInfoJSON/invalid_JSON (0.00s)399 --- PASS: TestParsePathInfoJSON/whitespace_only (0.00s)400 --- PASS: TestParsePathInfoJSON/empty_input (0.00s)401 --- PASS: TestParsePathInfoJSON/Nix_format (4.20s)402 --- PASS: TestParsePathInfoJSON/Lix_format (0.00s)403=== CONT TestStreamPushBatchesUnderLoad/oneAtATime=true404=== CONT TestSetClientTLS/rejects_connection_without_client_cert4052026/11/06 06:58:09 WARN Rate limiter enabled after throttle name=s3-test rate=54062026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:44441407--- PASS: TestPathInfoHashCompatibility (0.00s)408 --- PASS: TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI) (0.00s)409 --- PASS: TestPathInfoHashCompatibility/new_structured_format_with_sha512 (0.00s)410 --- PASS: TestPathInfoHashCompatibility/old_string_format_with_colon (0.00s)411 --- PASS: TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI (0.00s)412--- PASS: TestConvertHashToNix32 (0.00s)413 --- PASS: TestConvertHashToNix32/invalid_format (0.00s)414 --- PASS: TestConvertHashToNix32/SRI_format_to_Nix32 (0.00s)415 --- PASS: TestConvertHashToNix32/already_Nix32_format (0.00s)416--- PASS: TestEncodeNixBase32 (0.00s)417 --- PASS: TestEncodeNixBase32/empty_input (0.00s)418 --- PASS: TestEncodeNixBase32/test_string_hash (0.00s)419=== CONT TestPartSizeForNAR/small_stays_at_minimum420=== CONT TestSetClientTLS/preserves_debug_logging_transport4212026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=2 backoff=1ms status=502 url=http://127.0.0.1:38965422=== CONT TestPartSizeForNAR/zero_stays_at_minimum423--- PASS: TestUploadMultipart_SupersededByPeer (0.00s)424 --- PASS: TestUploadMultipart_SupersededByPeer/exists (0.32s)425 --- PASS: TestUploadMultipart_SupersededByPeer/missing (4.21s)426=== CONT TestSetClientTLS/succeeds_with_client_cert_and_CA427=== CONT TestPartSizeForNAR/capped_at_5_GiB428=== CONT TestPartSizeForNAR/5_TiB_S3_max_object429=== CONT TestPartSizeForNAR/1_TiB430=== CONT TestPartSizeForNAR/115_GiB_needs_larger_parts431=== CONT TestPartSizeForNAR/80_GiB_fits_at_minimum432--- PASS: TestParsePathInfoJSONMultiplePaths (0.00s)433 --- PASS: TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths (0.00s)434 --- PASS: TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths (0.00s)435--- PASS: TestCaseHackSuffix (6.75s)436--- PASS: TestRateLimiterFeedback (0.00s)437 --- PASS: TestRateLimiterFeedback/429_enables_limiter (4.53s)438 --- PASS: TestRateLimiterFeedback/503_enables_limiter (4.53s)439 --- PASS: TestRateLimiterFeedback/200_does_not_enable_limiter (4.53s)440 --- PASS: TestRateLimiterFeedback/400_does_not_enable_limiter (4.53s)441--- PASS: TestPartSizeForNAR (2.18s)442 --- PASS: TestPartSizeForNAR/small_stays_at_minimum (0.00s)443 --- PASS: TestPartSizeForNAR/zero_stays_at_minimum (0.00s)444 --- PASS: TestPartSizeForNAR/capped_at_5_GiB (0.00s)445 --- PASS: TestPartSizeForNAR/80_GiB_fits_at_minimum (0.00s)446 --- PASS: TestPartSizeForNAR/5_TiB_S3_max_object (0.00s)447 --- PASS: TestPartSizeForNAR/1_TiB (0.00s)448 --- PASS: TestPartSizeForNAR/115_GiB_needs_larger_parts (0.00s)449--- PASS: TestStreamPushBatchesUnderLoad (0.00s)450 --- PASS: TestStreamPushBatchesUnderLoad/oneAtATime=false (0.00s)451 --- PASS: TestStreamPushBatchesUnderLoad/oneAtATime=true (0.00s)452--- PASS: TestSetClientTLSErrors (0.04s)453 --- PASS: TestSetClientTLSErrors/missing_cert_file (0.00s)454 --- PASS: TestSetClientTLSErrors/invalid_ca_file (0.00s)455 --- PASS: TestSetClientTLSErrors/missing_key_file (0.00s)456 --- PASS: TestSetClientTLSErrors/missing_ca_file (0.00s)457--- PASS: TestUploadBuildLog_FileBodyReplayedOnRetry (6.71s)4582026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=1 backoff=1ms status=502 url=http://127.0.0.1:389654592026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=2 backoff=1ms status=502 url=http://127.0.0.1:389654602026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=3 backoff=1ms status=502 url=http://127.0.0.1:389654612026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=4 backoff=1ms status=502 url=http://127.0.0.1:389654622026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=5 backoff=1ms status=502 url=http://127.0.0.1:389654632026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=6 backoff=1ms status=502 url=http://127.0.0.1:389654642026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=7 backoff=1ms status=502 url=http://127.0.0.1:389654652026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=8 backoff=1ms status=502 url=http://127.0.0.1:389654662026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=9 backoff=1ms status=502 url=http://127.0.0.1:389654672026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=10 backoff=1ms status=502 url=http://127.0.0.1:38965468--- PASS: TestDumpPathWriterError (9.83s)4692026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=11 backoff=1ms status=502 url=http://127.0.0.1:389654702026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=12 backoff=1ms status=502 url=http://127.0.0.1:389654712026/11/06 06:58:09 http: TLS handshake error from 127.0.0.1:58122: remote error: tls: bad certificate472--- PASS: TestRegisterUploadedObjectReusesConnections (6.73s)473--- PASS: TestSetClientTLS (2.18s)474 --- PASS: TestSetClientTLS/preserves_debug_logging_transport (0.01s)475 --- PASS: TestSetClientTLS/succeeds_with_client_cert_and_CA (0.01s)476 --- PASS: TestSetClientTLS/rejects_connection_without_client_cert (0.02s)4772026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=13 backoff=1ms status=502 url=http://127.0.0.1:389654782026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=14 backoff=1ms status=502 url=http://127.0.0.1:389654792026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=15 backoff=1ms status=502 url=http://127.0.0.1:389654802026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=16 backoff=1ms status=502 url=http://127.0.0.1:389654812026/11/06 06:58:09 WARN Request returned retryable status, retrying attempt=17 backoff=1ms status=502 url=http://127.0.0.1:389654822026/11/06 06:58:09 WARN Rate limiter enabled after throttle name=s3-test rate=5483--- PASS: TestRetryTimeoutOutlastsMaxRetries (6.75s)4842026/11/06 06:58:09 WARN Request failed, retrying attempt=1 backoff=100ms error="Put \"http://127.0.0.1:35177/part/2\": uploading part 1: server returned 404: no such upload\n" url=http://127.0.0.1:35177/part/24852026/11/06 06:58:09 WARN Request failed, retrying attempt=1 backoff=100ms error="Put \"http://127.0.0.1:35177/part/3\": uploading part 1: server returned 404: no such upload\n" url=http://127.0.0.1:35177/part/34862026/11/06 06:58:09 WARN Request failed, retrying attempt=1 backoff=100ms error="Put \"http://127.0.0.1:35177/part/4\": uploading part 1: server returned 404: no such upload\n" url=http://127.0.0.1:35177/part/44872026/11/06 06:58:09 WARN Request failed, retrying attempt=1 backoff=100ms error="Put \"http://127.0.0.1:35177/part/5\": uploading part 1: server returned 404: no such upload\n" url=http://127.0.0.1:35177/part/54882026/11/06 06:58:09 ERROR Failed to close zstd encoder error="io: read/write on closed pipe"489--- PASS: TestRateLimiterFeedback_400DoesNotCountAsSuccess (6.95s)490--- PASS: TestSupersededNARStillUploadsListing (0.00s)491 --- PASS: TestSupersededNARStillUploadsListing/listing_upload_fails (4.54s)492 --- PASS: TestSupersededNARStillUploadsListing/small_NAR (6.71s)493 --- PASS: TestSupersededNARStillUploadsListing/dump_cut_short (7.25s)494--- PASS: TestUploadMultipart_PartsInParallel (7.34s)495--- PASS: TestUploadMultipart_FailedPartBufferNotReused (7.30s)496--- PASS: TestDumpPathMatchesNix (11.09s)497PASS498Running server tests...499The files belonging to this database system will be owned by user "nixbld".500This user must also own the server process.501502The database cluster will be initialized with locale "C".503The default database encoding has accordingly been set to "SQL_ASCII".504The default text search configuration will be set to "english".505506Data page checksums are enabled.507508creating directory /build/postgres2706796589/data ... ok509creating subdirectories ... ok510selecting dynamic shared memory implementation ... posix511selecting default "max_connections" ... 100512selecting default "shared_buffers" ... 128MB513selecting default time zone ... UTC514creating configuration files ... ok515running bootstrap script ... ok516performing post-bootstrap initialization ... ok517syncing data to disk ... ok518519initdb: warning: enabling "trust" authentication for local connections520initdb: 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.521522Success. You can now start the database server using:523524 pg_ctl -D /build/postgres2706796589/data -l logfile start525526/build/postgres2706796589:5432 - no response527/build/postgres2706796589:5432 - no response528/build/postgres2706796589:5432 - no response529/build/postgres2706796589:5432 - no response530/build/postgres2706796589:5432 - no response531/build/postgres2706796589:5432 - no response532/build/postgres2706796589:5432 - no response533/build/postgres2706796589:5432 - no response534/build/postgres2706796589:5432 - no response535/build/postgres2706796589:5432 - no response536/build/postgres2706796589:5432 - no response537/build/postgres2706796589:5432 - no response538/build/postgres2706796589:5432 - no response539/build/postgres2706796589:5432 - no response540/build/postgres2706796589:5432 - no response541/build/postgres2706796589:5432 - no response542/build/postgres2706796589:5432 - no response543/build/postgres2706796589:5432 - no response544/build/postgres2706796589:5432 - no response545/build/postgres2706796589:5432 - no response546/build/postgres2706796589:5432 - no response547/build/postgres2706796589:5432 - no response548/build/postgres2706796589:5432 - no response549/build/postgres2706796589:5432 - no response550/build/postgres2706796589:5432 - no response551/build/postgres2706796589:5432 - no response552/build/postgres2706796589:5432 - no response553/build/postgres2706796589:5432 - no response554/build/postgres2706796589:5432 - no response555/build/postgres2706796589:5432 - no response5562026-11-06 06:58:32.341 UTC [128] LOG: starting PostgreSQL 18.6 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit5572026-11-06 06:58:32.342 UTC [128] LOG: listening on Unix socket "/build/postgres2706796589/.s.PGSQL.5432"5582026-11-06 06:58:32.347 UTC [128] LOG: received smart shutdown request5592026-11-06 06:58:32.349 UTC [164] LOG: database system was shut down at 2026-11-06 06:58:28 UTC5602026-11-06 06:58:32.355 UTC [162] LOG: shutting down5612026-11-06 06:58:32.355 UTC [162] LOG: checkpoint starting: shutdown immediate5622026-11-06 06:58:32.359 UTC [162] 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/1765D585632026-11-06 06:58:32.379 UTC [128] LOG: database system is shut down5642026/11/06 06:58:32 ERROR failed to start postgres error="failed to wait for postgres: exit status 2"