2025-09-17 18:43:46,768 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initializeClass(5652)) - Initialize S3A class
2025-09-17 18:43:46,786 [setup] DEBUG s3a.S3ATestUtils (S3ATestUtils.java:removeBucketOverrides(908)) - Removing option fs.s3a.bucket.stevel--usw2-az1--x-s3.s3express.create.session; was false
2025-09-17 18:43:46,786 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initializeClass(5652)) - Initialize S3A class
2025-09-17 18:43:46,825 [setup] DEBUG impl.AbstractOperationAuditor (AbstractOperationAuditor.java:serviceInit(119)) - NoopAuditor: Out of span operations will be rejected
2025-09-17 18:43:46,826 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(583)) - Initializing S3AFileSystem for stevel--usw2-az1--x-s3
2025-09-17 18:43:46,830 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1102)) - Propagating entries under fs.s3a.bucket.stevel--usw2-az1--x-s3.
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.change.detection.mode from [core-site.xml]
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.fast.upload.buffer from [core-site.xml]
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.directory.marker.retention from [core-site.xml]
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.directory.operations.purge.uploads from [core-site.xml]
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.optimized.copy.from.local.enabled from [core-site.xml]
2025-09-17 18:43:46,833 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.multipart.threshold from [core-site.xml]
2025-09-17 18:43:46,834 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.endpoint.fips from [core-site.xml]
2025-09-17 18:43:46,834 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.fs.s3a.multipart.size from [core-site.xml]
2025-09-17 18:43:46,834 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.endpoint.region from [core-site.xml]
2025-09-17 18:43:46,834 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:propagateBucketOptions(1123)) - Updating fs.s3a.crt.enabled from [core-site.xml]
2025-09-17 18:43:46,834 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:maybeIsolateClassloader(1737)) - Configuration classloader set to S3AFileSystem classloader: jdk.internal.loader.ClassLoaders$AppClassLoader@5ffd2b27
2025-09-17 18:43:46,836 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(618)) - Using delegation tokens
2025-09-17 18:43:46,901 [setup] DEBUG s3a.S3AInstrumentation (S3AInstrumentation.java:getMetricsSystem(251)) - Metrics system inited org.apache.hadoop.metrics2.impl.MetricsSystemImpl@1c32886a
2025-09-17 18:43:46,908 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:buildEncryptionSecrets(1507)) - Data is unencrypted
2025-09-17 18:43:46,909 [setup] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:<init>(150)) - Retrying on recoverable AWS failures 3 times with an initial interval of 500ms
2025-09-17 18:43:46,913 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.paging.maximum is 5000
2025-09-17 18:43:46,913 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.block.size is 33554432
2025-09-17 18:43:46,914 [setup] DEBUG auth.SignerManager (SignerManager.java:initCustomSigners(68)) - No custom signers specified
2025-09-17 18:43:46,917 [setup] DEBUG audit.AuditIntegration (AuditIntegration.java:createAndInitAuditor(110)) - Auditor class is class org.apache.hadoop.fs.s3a.audit.impl.LoggingAuditor
2025-09-17 18:43:46,917 [setup] DEBUG impl.AbstractOperationAuditor (AbstractOperationAuditor.java:serviceInit(119)) - LoggingAuditor : Out of span operations will be rejected
2025-09-17 18:43:46,923 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:serviceInit(182)) - Initialized LoggingAuditor{ID='cf739331-1f2e-42dd-a5d9-f564d6023a23', headerEnabled=true, rejectOutOfSpan=true, isMultipartUploadEnabled=true}
2025-09-17 18:43:46,923 [setup] DEBUG impl.ActiveAuditManagerS3A (ActiveAuditManagerS3A.java:serviceInit(201)) - Audit manager initialized with audit service LoggingAuditor{ID='cf739331-1f2e-42dd-a5d9-f564d6023a23', headerEnabled=true, rejectOutOfSpan=true, isMultipartUploadEnabled=true}
2025-09-17 18:43:46,923 [setup] DEBUG impl.ActiveAuditManagerS3A (ActiveAuditManagerS3A.java:serviceStart(214)) - Started audit service LoggingAuditor{ID='cf739331-1f2e-42dd-a5d9-f564d6023a23', headerEnabled=true, rejectOutOfSpan=true, isMultipartUploadEnabled=true}
2025-09-17 18:43:46,923 [setup] DEBUG audit.AuditIntegration (AuditIntegration.java:createAndStartAuditManager(77)) - Started Audit Manager Service ActiveAuditManagerS3A in state ActiveAuditManagerS3A: STARTED, auditor=LoggingAuditor{ID='cf739331-1f2e-42dd-a5d9-f564d6023a23', headerEnabled=true, rejectOutOfSpan=true, isMultipartUploadEnabled=true}}
2025-09-17 18:43:46,924 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longOption(929)) - Value of fs.s3a.internal.upload.part.count.limit is 10000
2025-09-17 18:43:46,924 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:createRequestFactory(1322)) - Unset storage class property fs.s3a.create.storage.class; falling back to default storage class
2025-09-17 18:43:46,926 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.part.upload.timeout = PT15M
2025-09-17 18:43:46,930 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:createClientManager(1124)) - Using delegation tokens
2025-09-17 18:43:46,935 [setup] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:serviceInit(191)) - Filesystem s3a://stevel--usw2-az1--x-s3 is using delegation tokens of kind S3ADelegationToken/Session
2025-09-17 18:43:46,948 [setup] DEBUG auth.CredentialProviderListFactory (CredentialProviderListFactory.java:createAWSV2CredentialProvider(302)) - Credential provider class is org.apache.hadoop.fs.s3a.TemporaryAWSCredentialsProvider
2025-09-17 18:43:46,948 [setup] DEBUG auth.CredentialProviderListFactory (CredentialProviderListFactory.java:createAWSV2CredentialProvider(302)) - Credential provider class is org.apache.hadoop.fs.s3a.SimpleAWSCredentialsProvider
2025-09-17 18:43:46,949 [setup] DEBUG delegation.SessionTokenBinding (SessionTokenBinding.java:serviceStart(171)) - Setting parent authentication chain to AWSCredentialProviderList name=; refcount= 1; size=2: [TemporaryAWSCredentialsProvider, SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}]
2025-09-17 18:43:46,950 [setup] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:lookupToken(626)) - Looking for token for service s3a://stevel--usw2-az1--x-s3 in credentials
2025-09-17 18:43:46,950 [setup] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:lookupToken(646)) - No token for s3a://stevel--usw2-az1--x-s3 found
2025-09-17 18:43:46,950 [setup] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:deployUnbonded(247)) - No delegation tokens present: using direct authentication
2025-09-17 18:43:46,951 [setup] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:serviceStart(206)) - S3A Delegation support token (none) with Session token binding for user stevel, with STS endpoint "sts.eu-west-2.amazonaws.com", region "eu-west-2" and token duration 720:00
2025-09-17 18:43:46,951 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:createClientManager(1139)) - No delegation token for this instance
2025-09-17 18:43:46,951 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:createClientManager(1153)) - Using credential provider AWSCredentialProviderList name=; refcount= 1; size=2: [TemporaryAWSCredentialsProvider, SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}]
2025-09-17 18:43:46,958 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(735)) - Input fadvise policy = default
2025-09-17 18:43:46,960 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(737)) - Change detection policy = ETagChangeDetectionPolicy mode=Server
2025-09-17 18:43:46,960 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(741)) - Filesystem support for magic committers is enabled
2025-09-17 18:43:46,964 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.fast.upload.active.blocks is 4
2025-09-17 18:43:46,964 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(760)) - Using S3ABlockOutputStream with buffer = array; block=33554432; queue limit=4; multipart=true
2025-09-17 18:43:46,965 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(783)) - fs.s3a.create.performance = true
2025-09-17 18:43:46,965 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.bulk.delete.page.size is 250
2025-09-17 18:43:46,966 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.readahead.range is 32768
2025-09-17 18:43:46,966 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of io.file.buffer.size is 4194304
2025-09-17 18:43:46,967 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.input.async.drain.threshold is 1024
2025-09-17 18:43:46,967 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:initialize(804)) - Using optimized copyFromLocal implementation: false
2025-09-17 18:43:46,967 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.io.rate.limit is 0
2025-09-17 18:43:46,972 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.connection.maximum is 512
2025-09-17 18:43:46,972 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.acquisition.timeout = PT1M
2025-09-17 18:43:46,972 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.ttl = PT5M
2025-09-17 18:43:46,972 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.establish.timeout = PT30S
2025-09-17 18:43:46,972 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.idle.time = PT1M
2025-09-17 18:43:46,972 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.timeout = PT15S
2025-09-17 18:43:47,078 [setup] DEBUG s3a.DefaultS3ClientFactory (DefaultS3ClientFactory.java:configureEndpointAndRegion(398)) - Setting region to us-west-2 from fs.s3a.endpoint.region with cross region access true
2025-09-17 18:43:47,080 [setup] DEBUG s3a.DefaultS3ClientFactory (DefaultS3ClientFactory.java:maybeApplyS3AccessGrantsConfigurations(474)) - S3 Access Grants plugin is not enabled.
2025-09-17 18:43:47,081 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.connection.request.timeout = PT1M
2025-09-17 18:43:47,083 [setup] DEBUG impl.AWSClientConfig (AWSClientConfig.java:initUserAgent(388)) - Using User-Agent: Hadoop 3.5.0-SNAPSHOT
2025-09-17 18:43:47,083 [setup] DEBUG impl.AWSClientConfig (AWSClientConfig.java:initRequestHeaders(457)) - headers for S3 client = {}
2025-09-17 18:43:47,087 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.attempts.maximum is 2
2025-09-17 18:43:47,267 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.vectored.read.min.seek.size is 131072
2025-09-17 18:43:47,267 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.vectored.read.max.merged.size is 2097152
2025-09-17 18:43:47,268 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.vectored.active.ranged.reads is 4
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.max.total.tasks is 32
2025-09-17 18:43:47,269 [setup] DEBUG impl.ConfigurationHelper (ConfigurationHelper.java:getDuration(80)) - Duration of fs.s3a.threads.keepalivetime = PT1M
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.vectored.read.min.seek.size is 131072
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:longBytesOption(951)) - Value of fs.s3a.vectored.read.max.merged.size is 2097152
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.vectored.active.ranged.reads is 4
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AUtils (S3AUtils.java:intOption(908)) - Value of fs.s3a.executor.capacity is 16
2025-09-17 18:43:47,269 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:doBucketProbing(922)) - skipping check for bucket existence
2025-09-17 18:43:47,279 [setup] INFO  contract.AbstractFSContractTestBase (AbstractFSContractTestBase.java:setup(188)) - Test filesystem = s3a://stevel--usw2-az1--x-s3 implemented by S3AFileSystem{uri=s3a://stevel--usw2-az1--x-s3, workingDir=s3a://stevel--usw2-az1--x-s3/user/stevel, partSize=33554432, enableMultiObjectsDelete=true, maxKeys=5000, performanceFlags={Create}, OpenFileSupport{changePolicy=ETagChangeDetectionPolicy mode=Server, defaultReadAhead=32768, defaultBufferSize=4194304, defaultAsyncDrainThreshold=1024, defaultInputPolicy=default}, blockSize=33554432, multiPartThreshold=33554432, s3EncryptionAlgorithm='NONE', blockFactory=org.apache.hadoop.fs.s3a.S3ADataBlocks$ArrayBlockFactory@4cc36c19, auditManager=Service ActiveAuditManagerS3A in state ActiveAuditManagerS3A: STARTED, auditor=LoggingAuditor{ID='cf739331-1f2e-42dd-a5d9-f564d6023a23', headerEnabled=true, rejectOutOfSpan=true, isMultipartUploadEnabled=true}}, useListV1=false, magicCommitter=true, boundedExecutor=BlockingThreadPoolExecutorService{SemaphoredDelegatingExecutor{permitCount=192, available=192, waiting=0}, activeCount=0}, unboundedExecutor=java.util.concurrent.ThreadPoolExecutor@5a3a1bf9[Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0], credentials=AWSCredentialProviderList name=; refcount= 1; size=2: [TemporaryAWSCredentialsProvider, SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}], delegation tokens=S3ADelegationTokens{canonicalServiceURI=s3a://stevel--usw2-az1--x-s3; owner=stevel; isBoundToDT=false; token creation count=0; tokenManager=Service SessionTokens/001 in state SessionTokens/001: STARTED token kind = S3ADelegationToken/Session; token=(none)}, instrumentation {S3AInstrumentation{instanceIOStatistics=counters=((action_http_get_request.failures=0) (multipart_upload_part_put_bytes=0) (action_http_head_request=0) (conditional_create_failed=0) (stream_file_cache_eviction.failures=0) (op_exists.failures=0) (stream_file_cache_eviction=0) (op_access=0) (stream_read_seek_forward_operations=0) (http_response_503=0) (op_is_file=0) (store_io_throttled=0) (op_list_files.failures=0) (object_multipart_aborted=0) (op_exists=0) (op_hsync=0) (committer_tasks_completed=0) (committer_commit_job.failures=0) (store_exists_probe=0) (op_delete.failures=0) (audit_span_creation=1) (op_mkdirs=0) (audit_request_execution=0) (stream_read_close_operations=0) (action_executor_acquired.failures=0) (multipart_upload_part_put=0) (filesystem_close=0) (stream_write_block_uploads_committed=0) (stream_read_exceptions=0) (filesystem_initialization.failures=0) (stream_read_seek_bytes_skipped=0) (stream_read_fully_operations=0) (multipart_upload_completed=0) (stream_read_analytics_opened=0) (committer_commits_completed=0) (object_multipart_aborted.failures=0) (stream_write_exceptions=0) (multipart_instantiated=0) (object_list_request=0) (object_multipart_list=0) (op_list_status.failures=0) (stream_read_remote_stream_drain.failures=0) (op_glob_status=0) (object_continue_list_request.failures=0) (filesystem_initialization=1) (stream_read_unbuffered=0) (op_copy_from_local_file=0) (store_client_creation=1) (stream_read_vectored_operations=0) (op_get_content_summary.failures=0) (store_io_retry=0) (stream_read_operations=0) (op_rename.failures=0) (stream_write_total_data=0) (stream_read_bytes_backwards_on_seek=0) (op_list_status=0) (op_get_file_checksum=0) (object_delete_objects=0) (conditional_create=0) (object_delete_request.failures=0) (committer_commit_job=0) (stream_read_remote_stream_aborted.failures=0) (files_copied=0) (stream_read_total_bytes=0) (stream_read_version_mismatches=0) (op_xattr_get_named_map.failures=0) (stream_leaks=0) (op_get_file_status.failures=0) (multipart_upload_started=0) (http_response_400=0) (committer_commits_reverted=0) (op_createfile=0) (stream_read_bytes_discarded_in_abort=0) (op_xattr_get_named=0) (committer_stage_file_upload.failures=0) (committer_jobs_completed=0) (object_put_bytes=0) (stream_write_block_uploads_aborted=0) (op_bulk-delete=0) (ignored_errors=0) (delegation_tokens_issued.failures=0) (op_delete=0) (committer_magic_marker_put=0) (committer_load_single_pending_file=0) (stream_write_bytes=0) (op_xattr_list=0) (object_multipart_initiated=0) (op_xattr_get_named.failures=0) (committer_stage_file_upload=0) (op_glob_status.failures=0) (store_client_creation.failures=0) (op_abort.failures=0) (op_create=0) (audit_access_check_failure=0) (op_list_files=0) (op_get_delegation_token=0) (op_xattr_list.failures=0) (stream_write_total_time=0) (object_multipart_list.failures=0) (stream_read_operations_incomplete=0) (object_bulk_delete_request=0) (op_rename=0) (committer_commits_aborted=0) (committer_bytes_uploaded=0) (op_access.failures=0) (committer_bytes_committed=0) (object_put_request_completed=0) (stream_write_exceptions_completing_upload=0) (op_hflush=0) (stream_read_remote_stream_drain=0) (fake_directories_deleted=0) (object_delete_request=0) (stream_read_seek_policy_changed=0) (multipart_upload_list.failures=0) (action_executor_acquired=0) (files_deleted=0) (op_get_content_summary=0) (action_http_get_request=0) (op_open=0) (action_file_opened.failures=0) (stream_read_seek_bytes_discarded=0) (action_file_opened=0) (delegation_tokens_issued=0) (http_response_500=0) (object_metadata_request=0) (stream_read_remote_stream_aborted=0) (committer_magic_files_created=0) (op_mkdirs.failures=0) (op_xattr_get_named_map=0) (analytics_stream_factory_closed=0) (http_response_429=0) (op_createfile.failures=0) (op_get_file_status=0) (committer_magic_marker_put.failures=0) (directories_deleted=0) (committer_tasks_failed=0) (store_io_rate_limited_duration=0) (object_put_request=0) (op_xattr_get_map=0) (op_create_non_recursive=0) (op_xattr_get_map.failures=0) (op_get_delegation_token.failures=0) (files_created=0) (files_copied_bytes=0) (op_create.failures=0) (op_list_located_status=0) (stream_evict_blocks_from_cache=0) (files_delete_rejected=0) (multipart_upload_list=0) (committer_materialize_file.failures=0) (stream_read_bytes_discarded_in_close=0) (stream_read_bytes=0) (op_is_file.failures=0) (store_io_rate_limited_duration.failures=0) (committer_commits_created=0) (object_continue_list_request=0) (store_exists_probe.failures=0) (object_copy_requests=0) (stream_write_queue_duration=0) (op_copy_from_local_file.failures=0) (multipart_upload_aborted=0) (filesystem_close.failures=0) (op_abort=0) (committer_materialize_file=0) (object_bulk_delete_request.failures=0) (op_openfile=0) (http_response_4XX=0) (stream_read_seek_operations=0) (multipart_upload_abort_under_path_invoked=0) (action_http_head_request.failures=0) (stream_read_closed=0) (stream_aborted=0) (audit_failure=0) (stream_read_vectored_read_bytes_discarded=0) (op_is_directory=0) (op_get_file_checksum.failures=0) (http_response_5XX=0) (fake_directories_created=0) (directories_created=0) (object_put_request.failures=0) (committer_commits.failures=0) (object_list_request.failures=0) (stream_read_opened=0) (stream_write_block_uploads=0) (op_is_directory.failures=0) (committer_load_single_pending_file.failures=0) (store_io_request=0) (stream_read_vectored_combined_ranges=0) (stream_read_seek_backward_operations=0) (object_multipart_initiated.failures=0) (committer_jobs_failed=0) (stream_read_vectored_incoming_ranges=0) (stream_write_queue_duration.failures=0));
gauges=((stream_write_block_uploads_active=0) (client_side_encryption_enabled=0) (object_put_request_active=0) (stream_read_active_prefetch_operations=0) (stream_read_active_memory_in_use=0) (stream_write_block_uploads_pending=0) (stream_read_blocks_in_cache=0) (stream_write_block_uploads_data_pending=0) (object_put_bytes_pending=0));
minimums=((object_delete_request.failures.min=-1) (filesystem_close.min=-1) (object_multipart_list.min=-1) (committer_commit_job.failures.min=-1) (filesystem_close.failures.min=-1) (object_multipart_initiated.min=-1) (action_http_head_request.failures.min=-1) (op_is_file.min=-1) (op_xattr_get_named.failures.min=-1) (filesystem_initialization.min=364) (op_xattr_get_map.failures.min=-1) (op_delete.failures.min=-1) (op_rename.min=-1) (committer_magic_marker_put.failures.min=-1) (op_list_files.failures.min=-1) (op_xattr_list.min=-1) (op_createfile.min=-1) (action_http_head_request.min=-1) (object_put_request.failures.min=-1) (action_executor_acquired.min=-1) (store_io_rate_limited_duration.failures.min=-1) (op_get_file_status.failures.min=-1) (op_list_files.min=-1) (committer_load_single_pending_file.failures.min=-1) (store_exists_probe.min=-1) (action_executor_acquired.failures.min=-1) (store_io_rate_limited_duration.min=-1) (object_multipart_list.failures.min=-1) (op_xattr_list.failures.min=-1) (op_exists.failures.min=-1) (op_createfile.failures.min=-1) (op_abort.min=-1) (committer_load_single_pending_file.min=-1) (op_copy_from_local_file.failures.min=-1) (action_file_opened.failures.min=-1) (committer_materialize_file.min=-1) (op_get_delegation_token.min=-1) (op_mkdirs.min=-1) (op_xattr_get_named.min=-1) (object_multipart_aborted.min=-1) (stream_write_queue_duration.failures.min=-1) (op_abort.failures.min=-1) (stream_write_queue_duration.min=-1) (action_http_get_request.min=-1) (object_bulk_delete_request.failures.min=-1) (committer_stage_file_upload.failures.min=-1) (filesystem_initialization.failures.min=-1) (op_delete.min=-1) (op_copy_from_local_file.min=-1) (committer_magic_marker_put.min=-1) (op_get_content_summary.min=-1) (object_list_request.failures.min=-1) (op_rename.failures.min=-1) (op_xattr_get_named_map.min=-1) (stream_read_remote_stream_drain.failures.min=-1) (op_exists.min=-1) (op_get_delegation_token.failures.min=-1) (action_file_opened.min=-1) (multipart_upload_list.min=-1) (op_xattr_get_named_map.failures.min=-1) (stream_read_remote_stream_drain.min=-1) (op_get_file_checksum.min=-1) (store_client_creation.min=295) (op_create.min=-1) (committer_stage_file_upload.min=-1) (op_get_file_status.min=-1) (op_list_status.failures.min=-1) (object_list_request.min=-1) (op_access.min=-1) (committer_materialize_file.failures.min=-1) (op_is_file.failures.min=-1) (op_glob_status.min=-1) (stream_read_remote_stream_aborted.min=-1) (object_put_request.min=-1) (multipart_upload_list.failures.min=-1) (op_get_content_summary.failures.min=-1) (object_multipart_aborted.failures.min=-1) (op_is_directory.min=-1) (object_delete_request.min=-1) (stream_file_cache_eviction.failures.min=-1) (delegation_tokens_issued.failures.min=-1) (delegation_tokens_issued.min=-1) (op_create.failures.min=-1) (stream_file_cache_eviction.min=-1) (op_get_file_checksum.failures.min=-1) (op_glob_status.failures.min=-1) (object_bulk_delete_request.min=-1) (object_continue_list_request.min=-1) (committer_commit_job.min=-1) (object_multipart_initiated.failures.min=-1) (action_http_get_request.failures.min=-1) (op_xattr_get_map.min=-1) (op_is_directory.failures.min=-1) (op_access.failures.min=-1) (store_client_creation.failures.min=-1) (object_continue_list_request.failures.min=-1) (op_list_status.min=-1) (op_mkdirs.failures.min=-1) (store_exists_probe.failures.min=-1) (stream_read_remote_stream_aborted.failures.min=-1));
maximums=((object_continue_list_request.max=-1) (op_abort.failures.max=-1) (store_client_creation.max=295) (op_exists.failures.max=-1) (committer_magic_marker_put.failures.max=-1) (action_executor_acquired.max=-1) (op_access.failures.max=-1) (object_multipart_list.failures.max=-1) (committer_materialize_file.failures.max=-1) (store_io_rate_limited_duration.max=-1) (multipart_upload_list.max=-1) (object_list_request.failures.max=-1) (delegation_tokens_issued.failures.max=-1) (op_rename.failures.max=-1) (op_copy_from_local_file.failures.max=-1) (object_multipart_aborted.max=-1) (op_is_file.max=-1) (op_get_content_summary.max=-1) (op_is_file.failures.max=-1) (op_is_directory.failures.max=-1) (op_is_directory.max=-1) (filesystem_close.max=-1) (stream_read_remote_stream_aborted.failures.max=-1) (op_create.max=-1) (op_delete.failures.max=-1) (multipart_upload_list.failures.max=-1) (op_get_file_status.failures.max=-1) (stream_file_cache_eviction.failures.max=-1) (stream_read_remote_stream_drain.max=-1) (committer_stage_file_upload.max=-1) (op_createfile.max=-1) (op_get_delegation_token.failures.max=-1) (op_xattr_get_named_map.failures.max=-1) (op_glob_status.failures.max=-1) (committer_stage_file_upload.failures.max=-1) (store_client_creation.failures.max=-1) (action_file_opened.max=-1) (op_xattr_get_named.max=-1) (store_exists_probe.max=-1) (stream_write_queue_duration.max=-1) (object_multipart_initiated.max=-1) (op_xattr_get_map.max=-1) (object_multipart_aborted.failures.max=-1) (op_list_files.max=-1) (object_delete_request.failures.max=-1) (op_access.max=-1) (filesystem_initialization.max=364) (op_get_file_checksum.failures.max=-1) (committer_magic_marker_put.max=-1) (op_exists.max=-1) (store_exists_probe.failures.max=-1) (op_list_status.max=-1) (store_io_rate_limited_duration.failures.max=-1) (object_put_request.max=-1) (action_http_get_request.max=-1) (filesystem_close.failures.max=-1) (action_http_head_request.max=-1) (object_multipart_list.max=-1) (op_get_content_summary.failures.max=-1) (op_glob_status.max=-1) (committer_commit_job.max=-1) (stream_write_queue_duration.failures.max=-1) (op_delete.max=-1) (object_delete_request.max=-1) (committer_load_single_pending_file.failures.max=-1) (op_rename.max=-1) (op_createfile.failures.max=-1) (op_mkdirs.max=-1) (object_put_request.failures.max=-1) (op_abort.max=-1) (op_xattr_list.failures.max=-1) (action_http_head_request.failures.max=-1) (stream_read_remote_stream_drain.failures.max=-1) (op_create.failures.max=-1) (action_file_opened.failures.max=-1) (committer_commit_job.failures.max=-1) (object_bulk_delete_request.failures.max=-1) (op_copy_from_local_file.max=-1) (op_xattr_get_named_map.max=-1) (op_get_delegation_token.max=-1) (object_continue_list_request.failures.max=-1) (stream_read_remote_stream_aborted.max=-1) (op_get_file_status.max=-1) (action_executor_acquired.failures.max=-1) (object_multipart_initiated.failures.max=-1) (object_bulk_delete_request.max=-1) (op_mkdirs.failures.max=-1) (object_list_request.max=-1) (op_list_status.failures.max=-1) (op_list_files.failures.max=-1) (action_http_get_request.failures.max=-1) (op_xattr_get_named.failures.max=-1) (op_get_file_checksum.max=-1) (committer_load_single_pending_file.max=-1) (delegation_tokens_issued.max=-1) (filesystem_initialization.failures.max=-1) (committer_materialize_file.max=-1) (op_xattr_get_map.failures.max=-1) (op_xattr_list.max=-1) (stream_file_cache_eviction.max=-1));
means=((op_is_directory.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_io_rate_limited_duration.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_http_get_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_list_request.mean=(samples=0, sum=0, mean=0.0000)) (op_list_files.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.mean=(samples=0, sum=0, mean=0.0000)) (op_mkdirs.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_bulk_delete_request.mean=(samples=0, sum=0, mean=0.0000)) (committer_materialize_file.mean=(samples=0, sum=0, mean=0.0000)) (action_http_head_request.mean=(samples=0, sum=0, mean=0.0000)) (object_list_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_stage_file_upload.mean=(samples=0, sum=0, mean=0.0000)) (object_bulk_delete_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_createfile.mean=(samples=0, sum=0, mean=0.0000)) (stream_write_queue_duration.mean=(samples=0, sum=0, mean=0.0000)) (op_glob_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_aborted.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_map.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_create.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_list.mean=(samples=0, sum=0, mean=0.0000)) (op_delete.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_exists.mean=(samples=0, sum=0, mean=0.0000)) (op_get_delegation_token.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_initialization.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_glob_status.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.mean=(samples=0, sum=0, mean=0.0000)) (committer_stage_file_upload.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_http_head_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_file_cache_eviction.mean=(samples=0, sum=0, mean=0.0000)) (committer_commit_job.mean=(samples=0, sum=0, mean=0.0000)) (op_get_content_summary.mean=(samples=0, sum=0, mean=0.0000)) (committer_commit_job.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_copy_from_local_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_list_files.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_copy_from_local_file.mean=(samples=0, sum=0, mean=0.0000)) (action_file_opened.mean=(samples=0, sum=0, mean=0.0000)) (op_access.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_checksum.mean=(samples=0, sum=0, mean=0.0000)) (op_is_file.mean=(samples=0, sum=0, mean=0.0000)) (stream_write_queue_duration.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_file_opened.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_list_status.mean=(samples=0, sum=0, mean=0.0000)) (op_delete.mean=(samples=0, sum=0, mean=0.0000)) (op_createfile.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_http_get_request.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_list.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_close.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_client_creation.mean=(samples=1, sum=295, mean=295.0000)) (op_rename.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_directory.mean=(samples=0, sum=0, mean=0.0000)) (delegation_tokens_issued.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_exists.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_content_summary.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_materialize_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_exists_probe.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_io_rate_limited_duration.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_list_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_continue_list_request.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_list.mean=(samples=0, sum=0, mean=0.0000)) (object_delete_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_access.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_initialization.mean=(samples=1, sum=364, mean=364.0000)) (op_get_file_checksum.failures.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_close.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.mean=(samples=0, sum=0, mean=0.0000)) (op_get_delegation_token.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_load_single_pending_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_exists_probe.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named_map.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_map.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_file_cache_eviction.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_drain.mean=(samples=0, sum=0, mean=0.0000)) (delegation_tokens_issued.mean=(samples=0, sum=0, mean=0.0000)) (op_mkdirs.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_create.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named_map.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_drain.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.mean=(samples=0, sum=0, mean=0.0000)) (object_continue_list_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_status.mean=(samples=0, sum=0, mean=0.0000)) (object_delete_request.mean=(samples=0, sum=0, mean=0.0000)) (op_rename.mean=(samples=0, sum=0, mean=0.0000)) (committer_load_single_pending_file.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_aborted.mean=(samples=0, sum=0, mean=0.0000)) (store_client_creation.failures.mean=(samples=0, sum=0, mean=0.0000)));
}}, ClientSideEncryption=false}
2025-09-17 18:43:47,284 [setup] DEBUG impl.MkdirOperation (MkdirOperation.java:execute(120)) - Making directory: s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:47,285 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerGetFileStatus(3966)) - Getting path status for s3a://stevel--usw2-az1--x-s3/test  (test); needEmptyDirectory=false
2025-09-17 18:43:47,285 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4025)) - S3GetFileStatus s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:47,289 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:listObjects(3084)) - LIST List stevel--usw2-az1--x-s3:/test/ delimiter=/ keys=2 requester pays=null
2025-09-17 18:43:47,289 [setup] DEBUG s3a.S3AFileSystem (DurationInfo.java:<init>(80)) - Starting: LIST
2025-09-17 18:43:47,321 [setup] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: create credentials
2025-09-17 18:43:47,323 [setup] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - create credentials: duration 0:00.002s
2025-09-17 18:43:47,323 [setup] DEBUG s3a.AWSCredentialProviderList (AWSCredentialProviderList.java:resolveCredentials(195)) - No credentials from TemporaryAWSCredentialsProvider: org.apache.hadoop.fs.s3a.auth.NoAwsCredentialsException: Session credentials in Hadoop configuration: No AWS Credentials
2025-09-17 18:43:47,324 [setup] DEBUG s3a.AWSCredentialProviderList (AWSCredentialProviderList.java:resolveCredentials(182)) - Using credentials from SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}
2025-09-17 18:43:47,334 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005 Executing op_mkdirs with {object_list_request 'test/' size=2, mutating=false}; https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284
2025-09-17 18:43:47,347 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=GET, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[list-type, delimiter, max-keys, prefix])
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "GET /?list-type=2&delimiter=%2F&max-keys=2&prefix=test%2F HTTP/1.1[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-invocation-id: 6e9da761-dd66-4a87-263a-94718ce42e89[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=3b4e17956b594712a920f11affc7839d40aa454ebc93fff0c0a136351b073858[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Referer: https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284[\r][\n]"
2025-09-17 18:43:47,905 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:47,906 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:47,906 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "X-Amz-Date: 20250917T174347Z[\r][\n]"
2025-09-17 18:43:47,906 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:47,906 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "[\r][\n]"
2025-09-17 18:43:48,096 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:48,097 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:48,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-request-id: 0191c3e05300019958c6803405099e79062a8868[\r][\n]"
2025-09-17 18:43:48,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-id-2: k8DUYxutJ6FvpJq0br[\r][\n]"
2025-09-17 18:43:48,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:48,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "content-length: 279[\r][\n]"
2025-09-17 18:43:48,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-bucket-region: us-west-2[\r][\n]"
2025-09-17 18:43:48,099 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "date: Wed, 17 Sep 2025 17:43:47 GMT[\r][\n]"
2025-09-17 18:43:48,099 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "[\r][\n]"
2025-09-17 18:43:48,120 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "<?xml version="1.0" encoding="UTF-8"?>[\n]"
2025-09-17 18:43:48,120 [setup] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-0 << "<ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>stevel--usw2-az1--x-s3</Name><Prefix>test/</Prefix><KeyCount>0</KeyCount><MaxKeys>2</MaxKeys><IsTruncated>false</IsTruncated><Delimiter>/</Delimiter></ListBucketResult>"
2025-09-17 18:43:48,130 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 0191c3e05300019958c6803405099e79062a8868, Extended Request ID: k8DUYxutJ6FvpJq0br
2025-09-17 18:43:48,136 [setup] DEBUG s3a.S3AFileSystem (DurationInfo.java:close(101)) - LIST: duration 0:00.846s
2025-09-17 18:43:48,136 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4109)) - Not Found: s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:48,136 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerGetFileStatus(3966)) - Getting path status for s3a://stevel--usw2-az1--x-s3/test  (test); needEmptyDirectory=false
2025-09-17 18:43:48,136 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4025)) - S3GetFileStatus s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:48,141 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:lambda$headObject$3(683)) - HEAD test with change tracker null
2025-09-17 18:43:48,144 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005 Executing op_mkdirs with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284
2025-09-17 18:43:48,144 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=HEAD, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "HEAD /test HTTP/1.1[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-invocation-id: 60c607bd-2bf3-198e-33d5-331187a6d556[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=21532f586d14ae00065e224358f1e256be41ac8f7d802911c4590458e8472dbb[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Referer: https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:48,146 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:48,147 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "X-Amz-Date: 20250917T174348Z[\r][\n]"
2025-09-17 18:43:48,147 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:48,147 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "[\r][\n]"
2025-09-17 18:43:48,299 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "HTTP/1.1 404 Not Found[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-request-id: 01d272a9e200019958c6812505095b07aada5317[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-id-2: PgXyIz4aGd0fga[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "date: Wed, 17 Sep 2025 17:43:47 GMT[\r][\n]"
2025-09-17 18:43:48,300 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "[\r][\n]"
2025-09-17 18:43:48,306 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received failed response: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga
2025-09-17 18:43:48,311 [setup] DEBUG s3a.Invoker (Invoker.java:retryUntranslated(474)) - HEAD test ; software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga), 
2025-09-17 18:43:48,312 [setup] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:shouldRetry(318)) - Retry probe for FileNotFoundException with 0 retries and 0 failovers, idempotent=true, due to java.io.FileNotFoundException: HEAD test on /: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga):NoSuchKey
java.io.FileNotFoundException: HEAD test on /: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga):NoSuchKey
	at org.apache.hadoop.fs.s3a.S3AUtils.translateException(S3AUtils.java:283)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:481)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.headObject(S3AStoreImpl.java:675)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3045)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3025)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:4040)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3968)
	at org.apache.hadoop.fs.s3a.S3AFileSystem$MkdirOperationCallbacksImpl.probePathStatus(S3AFileSystem.java:3827)
	at org.apache.hadoop.fs.s3a.impl.MkdirOperation.probePathStatusOrNull(MkdirOperation.java:216)
	at org.apache.hadoop.fs.s3a.impl.MkdirOperation.getPathStatusExpectingDir(MkdirOperation.java:240)
	at org.apache.hadoop.fs.s3a.impl.MkdirOperation.execute(MkdirOperation.java:134)
	at org.apache.hadoop.fs.s3a.impl.MkdirOperation.execute(MkdirOperation.java:59)
	at org.apache.hadoop.fs.s3a.impl.ExecutingStoreOperation.apply(ExecutingStoreOperation.java:76)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2874)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2893)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.mkdirs(S3AFileSystem.java:3798)
	at org.apache.hadoop.fs.FileSystem.mkdirs(FileSystem.java:2496)
	at org.apache.hadoop.fs.contract.AbstractFSContractTestBase.mkdirs(AbstractFSContractTestBase.java:355)
	at org.apache.hadoop.fs.contract.AbstractFSContractTestBase.setup(AbstractFSContractTestBase.java:197)
	at org.apache.hadoop.fs.s3a.AbstractS3ATestBase.setup(AbstractS3ATestBase.java:111)
	at org.apache.hadoop.fs.s3a.performance.AbstractS3ACostTest.setup(AbstractS3ACostTest.java:105)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:568)
	at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:787)
	at org.junit.platform.commons.support.ReflectionSupport.invokeMethod(ReflectionSupport.java:478)
	at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
	at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:161)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptLifecycleMethod(TimeoutExtension.java:133)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptBeforeEachMethod(TimeoutExtension.java:83)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:112)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:94)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:93)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:87)
	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.invokeMethodInExtensionContext(ClassBasedTestDescriptor.java:547)
	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.lambda$synthesizeBeforeEachMethodAdapter$20(ClassBasedTestDescriptor.java:532)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeBeforeEachMethods$2(TestMethodTestDescriptor.java:193)
	at org.junit.jupiter.engine.descriptor.CallbackSupport.lambda$invokeBeforeCallbacks$0(CallbackSupport.java:34)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.jupiter.engine.descriptor.CallbackSupport.invokeBeforeCallbacks(CallbackSupport.java:34)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeBeforeEachMethods(TestMethodTestDescriptor.java:191)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:155)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:70)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:157)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.executeEngine(EngineExecutionOrchestrator.java:230)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.failOrExecuteEngine(EngineExecutionOrchestrator.java:204)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:172)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:101)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:64)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:150)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:63)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:109)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:91)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.junit.platform.launcher.core.InterceptingLauncher.lambda$execute$1(InterceptingLauncher.java:39)
	at org.junit.platform.launcher.core.ClasspathAlignmentCheckingLauncherInterceptor.intercept(ClasspathAlignmentCheckingLauncherInterceptor.java:25)
	at org.junit.platform.launcher.core.InterceptingLauncher.execute(InterceptingLauncher.java:38)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.apache.maven.surefire.junitplatform.LazyLauncher.execute(LazyLauncher.java:56)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.execute(JUnitPlatformProvider.java:194)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:150)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:122)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:385)
	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:507)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:495)
Caused by: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 01d272a9e200019958c6812505095b07aada5317, Extended Request ID: PgXyIz4aGd0fga)
	at software.amazon.awssdk.services.s3.model.NoSuchKeyException$BuilderImpl.build(NoSuchKeyException.java:150)
	at software.amazon.awssdk.services.s3.model.NoSuchKeyException$BuilderImpl.build(NoSuchKeyException.java:98)
	at software.amazon.awssdk.services.s3.internal.handlers.ExceptionTranslationInterceptor.modifyException(ExceptionTranslationInterceptor.java:65)
	at software.amazon.awssdk.core.interceptor.ExecutionInterceptorChain.modifyException(ExecutionInterceptorChain.java:181)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.ExceptionReportingUtils.runModifyException(ExceptionReportingUtils.java:54)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.ExceptionReportingUtils.reportFailureToInterceptors(ExceptionReportingUtils.java:38)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:39)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:26)
	at software.amazon.awssdk.core.internal.http.AmazonSyncHttpClient$RequestExecutionBuilderImpl.execute(AmazonSyncHttpClient.java:210)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.invoke(BaseSyncClientHandler.java:103)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.doExecute(BaseSyncClientHandler.java:173)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.lambda$execute$1(BaseSyncClientHandler.java:80)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.measureApiCallSuccess(BaseSyncClientHandler.java:182)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.execute(BaseSyncClientHandler.java:74)
	at software.amazon.awssdk.core.client.handler.SdkSyncClientHandler.execute(SdkSyncClientHandler.java:45)
	at software.amazon.awssdk.awscore.client.handler.AwsSyncClientHandler.execute(AwsSyncClientHandler.java:53)
	at software.amazon.awssdk.services.s3.DefaultS3Client.headObject(DefaultS3Client.java:7623)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.lambda$headObject$59(DelegatingS3Client.java:6180)
	at software.amazon.awssdk.services.s3.internal.crossregion.S3CrossRegionSyncClient.invokeOperation(S3CrossRegionSyncClient.java:67)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.headObject(DelegatingS3Client.java:6180)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.lambda$headObject$3(S3AStoreImpl.java:688)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468)
	... 104 more
2025-09-17 18:43:48,314 [setup] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:shouldRetry(323)) - Retry action is RetryAction(action=FAIL, delayMillis=0, reason=try once and fail.)
2025-09-17 18:43:48,315 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4109)) - Not Found: s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:48,321 [setup] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: PUT 0-byte object 
2025-09-17 18:43:48,327 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:putObjectDirect(3317)) - PUT 0 bytes to test/
2025-09-17 18:43:48,327 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:incrementPutStartStatistics(510)) - PUT start 0 bytes
2025-09-17 18:43:48,332 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005 Executing op_mkdirs with {object_put_request 'test/' size=0, mutating=true}; https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284
2025-09-17 18:43:48,333 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=PUT, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/, headers=[amz-sdk-invocation-id, Content-Length, Content-Type, Expect, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "PUT /test/ HTTP/1.1[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-invocation-id: 9d96f2da-f4ba-b4cc-dfae-447b1a5462ca[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-type;host;referer;x-amz-content-sha256;x-amz-date, Signature=83ba838502ccd74547d0627f9267d7b0eaf59567f4114b233dcda6ca0cd96e19[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Content-Type: application/x-directory[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Expect: 100-continue[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Referer: https://audit.example.org/hadoop/1/op_mkdirs/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005/?op=op_mkdirs&p1=test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000005&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131027284[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB md/rb#u m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "X-Amz-Date: 20250917T174348Z[\r][\n]"
2025-09-17 18:43:48,336 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Content-Length: 0[\r][\n]"
2025-09-17 18:43:48,337 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:48,337 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "[\r][\n]"
2025-09-17 18:43:48,506 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:48,506 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "date: Wed, 17 Sep 2025 17:43:48 GMT[\r][\n]"
2025-09-17 18:43:48,506 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:48,506 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-request-id: 013814060100019958c681e305091d52bb7fd788[\r][\n]"
2025-09-17 18:43:48,506 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-id-2: 85ie4lT[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "etag: "927605342e6d4d38b420a5b420523775"[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-expiration: NotImplemented[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-server-side-encryption: AES256[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-checksum-crc64nvme: AAAAAAAAAAA=[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "x-amz-checksum-type: FULL_OBJECT[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "transfer-encoding: chunked[\r][\n]"
2025-09-17 18:43:48,507 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "[\r][\n]"
2025-09-17 18:43:48,510 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 013814060100019958c681e305091d52bb7fd788, Extended Request ID: 85ie4lT
2025-09-17 18:43:48,511 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "0[\r][\n]"
2025-09-17 18:43:48,511 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 << "[\r][\n]"
2025-09-17 18:43:48,511 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:incrementPutCompletedStatistics(527)) - PUT completed success=true; 0 bytes
2025-09-17 18:43:48,512 [setup] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - PUT 0-byte object : duration 0:00.190s
2025-09-17 18:43:48,512 [setup] DEBUG S3AFileSystem.Progress (S3AStoreImpl.java:incrementPutProgressStatistics(545)) - PUT test: 0 bytes
2025-09-17 18:43:48,538 [setup] INFO  contract.AbstractFSContractTestBase (AbstractFSContractTestBase.java:describe(272)) - Performing getFileStatus() on a file
2025-09-17 18:43:48,540 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerCreateFile(2171)) - Skipping all probes with flags: createPerf=true, magic=false, ccAvailable=true, cCreate=false, cEtag=false
2025-09-17 18:43:48,546 [setup] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:<init>(150)) - Retrying on recoverable AWS failures 3 times with an initial interval of 500ms
2025-09-17 18:43:48,550 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:<init>(296)) - Initialized S3ABlockOutputStream for test/testSDKMetricsCostOfGetFileStatusOnFile output to ByteArrayBlock{index=0, state=Writing, limit=33554432, dataSize=null}
2025-09-17 18:43:48,552 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:close(507)) - S3ABlockOutputStream{WriteOperationHelper {bucket=stevel--usw2-az1--x-s3}, blockSize=33554432, isMultipartUploadEnabled=true, activeBlock=ByteArrayBlock{index=0, state=Writing, limit=33554432, dataSize=null} Statistics=counters=((conditional_create_failed=0) (op_abort.failures=0) (conditional_create=0) (object_put_request=0) (stream_write_exceptions=0) (stream_write_total_data=0) (object_multipart_initiated=0) (stream_write_block_uploads=0) (committer_magic_marker_put=0) (op_hflush=0) (stream_write_exceptions_completing_upload=0) (op_abort=0) (object_multipart_initiated.failures=0) (multipart_upload_completed.failures=0) (action_executor_acquired.failures=0) (op_hsync=0) (stream_write_queue_duration=0) (object_put_request.failures=0) (multipart_upload_completed=0) (multipart_upload_part_put=0) (object_multipart_aborted=0) (action_executor_acquired=0) (committer_magic_marker_put.failures=0) (stream_write_total_time=0) (object_multipart_aborted.failures=0) (stream_write_bytes=0) (multipart_upload_part_put.failures=0));
gauges=((stream_write_block_uploads_pending=0) (stream_write_block_uploads_data_pending=0) (stream_write_block_uploads_active=0));
minimums=((object_multipart_aborted.min=-1) (multipart_upload_part_put.min=-1) (action_executor_acquired.failures.min=-1) (committer_magic_marker_put.min=-1) (object_multipart_aborted.failures.min=-1) (op_abort.failures.min=-1) (multipart_upload_completed.min=-1) (object_put_request.failures.min=-1) (object_put_request.min=-1) (object_multipart_initiated.failures.min=-1) (action_executor_acquired.min=-1) (committer_magic_marker_put.failures.min=-1) (multipart_upload_part_put.failures.min=-1) (object_multipart_initiated.min=-1) (op_abort.min=-1) (multipart_upload_completed.failures.min=-1));
maximums=((action_executor_acquired.failures.max=-1) (op_abort.max=-1) (multipart_upload_completed.failures.max=-1) (action_executor_acquired.max=-1) (committer_magic_marker_put.max=-1) (committer_magic_marker_put.failures.max=-1) (object_multipart_aborted.max=-1) (object_multipart_initiated.failures.max=-1) (op_abort.failures.max=-1) (object_multipart_initiated.max=-1) (object_put_request.failures.max=-1) (multipart_upload_part_put.max=-1) (multipart_upload_completed.max=-1) (object_put_request.max=-1) (object_multipart_aborted.failures.max=-1) (multipart_upload_part_put.failures.max=-1));
means=((object_multipart_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_completed.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_part_put.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_aborted.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.failures.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_part_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_completed.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.mean=(samples=0, sum=0, mean=0.0000)));
}: Closing block #1: current block= ByteArrayBlock{index=0, state=Writing, limit=33554432, dataSize=null}
2025-09-17 18:43:48,552 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:putObject(708)) - Executing regular upload for WriteOperationHelper {bucket=stevel--usw2-az1--x-s3}
2025-09-17 18:43:48,552 [setup] DEBUG s3a.S3ADataBlocks (S3ADataBlocks.java:startUpload(362)) - Start datablock[0] upload
2025-09-17 18:43:48,553 [setup] DEBUG s3a.S3ADataBlocks (S3ADataBlocks.java:enterState(261)) - ByteArrayBlock{index=0, state=Writing, limit=33554432, dataSize=null}: entering state Upload
2025-09-17 18:43:48,553 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:clearActiveBlock(340)) - Clearing active block
2025-09-17 18:43:48,554 [setup] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: Writing Object
2025-09-17 18:43:48,554 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:putObjectDirect(3317)) - PUT 0 bytes to test/testSDKMetricsCostOfGetFileStatusOnFile
2025-09-17 18:43:48,555 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:incrementPutStartStatistics(510)) - PUT start 0 bytes
2025-09-17 18:43:48,556 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006 Executing op_create with {object_put_request 'test/testSDKMetricsCostOfGetFileStatusOnFile' size=0, mutating=true}; https://audit.example.org/hadoop/1/op_create/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006/?op=op_create&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131028540
2025-09-17 18:43:48,556 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=PUT, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/testSDKMetricsCostOfGetFileStatusOnFile, headers=[amz-sdk-invocation-id, Content-Length, Content-Type, Expect, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "PUT /test/testSDKMetricsCostOfGetFileStatusOnFile HTTP/1.1[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-invocation-id: 6e900670-40a3-f6d4-29b0-6661d7811e52[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-type;host;referer;x-amz-content-sha256;x-amz-date, Signature=27ef61c82629c239ba1bc35fb2761f820c5a899e787c20a2a1a7e1c728eea1a1[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Content-Type: application/octet-stream[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Expect: 100-continue[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Referer: https://audit.example.org/hadoop/1/op_create/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006/?op=op_create&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131028540[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB md/rb#u m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "X-Amz-Date: 20250917T174348Z[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Content-Length: 0[\r][\n]"
2025-09-17 18:43:48,557 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:48,558 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-0 >> "[\r][\n]"
2025-09-17 18:43:48,558 [setup] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-0 << "end of stream"
2025-09-17 18:43:48,558 [setup] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-0 << "end of stream"
2025-09-17 18:43:48,560 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(125)) - Retryable error detected. Will retry in 23ms. Request attempt number 1
software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: The target server failed to respond
	at software.amazon.awssdk.core.exception.SdkClientException$BuilderImpl.build(SdkClientException.java:130)
	at software.amazon.awssdk.core.exception.SdkClientException.create(SdkClientException.java:47)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.RetryableStageHelper.setLastException(RetryableStageHelper.java:231)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:65)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:36)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.StreamManagingStage.execute(StreamManagingStage.java:53)
	at software.amazon.awssdk.core.internal.http.StreamManagingStage.execute(StreamManagingStage.java:35)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.executeWithTimer(ApiCallTimeoutTrackingStage.java:82)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.execute(ApiCallTimeoutTrackingStage.java:62)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.execute(ApiCallTimeoutTrackingStage.java:43)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallMetricCollectionStage.execute(ApiCallMetricCollectionStage.java:50)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallMetricCollectionStage.execute(ApiCallMetricCollectionStage.java:32)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:37)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:26)
	at software.amazon.awssdk.core.internal.http.AmazonSyncHttpClient$RequestExecutionBuilderImpl.execute(AmazonSyncHttpClient.java:210)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.invoke(BaseSyncClientHandler.java:103)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.doExecute(BaseSyncClientHandler.java:173)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.lambda$execute$1(BaseSyncClientHandler.java:80)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.measureApiCallSuccess(BaseSyncClientHandler.java:182)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.execute(BaseSyncClientHandler.java:74)
	at software.amazon.awssdk.core.client.handler.SdkSyncClientHandler.execute(SdkSyncClientHandler.java:45)
	at software.amazon.awssdk.awscore.client.handler.AwsSyncClientHandler.execute(AwsSyncClientHandler.java:53)
	at software.amazon.awssdk.services.s3.DefaultS3Client.putObject(DefaultS3Client.java:11883)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.lambda$putObject$89(DelegatingS3Client.java:9716)
	at software.amazon.awssdk.services.s3.internal.crossregion.S3CrossRegionSyncClient.invokeOperation(S3CrossRegionSyncClient.java:67)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.putObject(DelegatingS3Client.java:9716)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$putObjectDirect$14(S3AFileSystem.java:3325)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDurationOfSupplier(IOStatisticsBinding.java:651)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.putObjectDirect(S3AFileSystem.java:3323)
	at org.apache.hadoop.fs.s3a.WriteOperationHelper.lambda$putObject$7(WriteOperationHelper.java:535)
	at org.apache.hadoop.fs.store.audit.AuditingFunctions.lambda$withinAuditSpan$0(AuditingFunctions.java:62)
	at org.apache.hadoop.fs.s3a.Invoker.once(Invoker.java:122)
	at org.apache.hadoop.fs.s3a.Invoker.lambda$retry$4(Invoker.java:376)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468)
	at org.apache.hadoop.fs.s3a.Invoker.retry(Invoker.java:372)
	at org.apache.hadoop.fs.s3a.Invoker.retry(Invoker.java:347)
	at org.apache.hadoop.fs.s3a.WriteOperationHelper.retry(WriteOperationHelper.java:210)
	at org.apache.hadoop.fs.s3a.WriteOperationHelper.putObject(WriteOperationHelper.java:534)
	at org.apache.hadoop.fs.s3a.S3ABlockOutputStream.putObject(S3ABlockOutputStream.java:726)
	at org.apache.hadoop.fs.s3a.S3ABlockOutputStream.close(S3ABlockOutputStream.java:518)
	at org.apache.hadoop.fs.FSDataOutputStream$PositionCache.close(FSDataOutputStream.java:77)
	at org.apache.hadoop.fs.FSDataOutputStream.close(FSDataOutputStream.java:106)
	at org.apache.hadoop.fs.s3a.performance.AbstractS3ACostTest.file(AbstractS3ACostTest.java:193)
	at org.apache.hadoop.fs.s3a.performance.AbstractS3ACostTest.file(AbstractS3ACostTest.java:182)
	at org.apache.hadoop.fs.s3a.statistics.ITestAWSStatisticCollection.testSDKMetricsCostOfGetFileStatusOnFile(ITestAWSStatisticCollection.java:57)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:568)
	at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:787)
	at org.junit.platform.commons.support.ReflectionSupport.invokeMethod(ReflectionSupport.java:478)
	at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
	at org.junit.jupiter.engine.extension.SameThreadTimeoutInvocation.proceed(SameThreadTimeoutInvocation.java:49)
	at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:161)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:152)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:91)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:112)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:94)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:93)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:87)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$4(TestMethodTestDescriptor.java:221)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:217)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:159)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:70)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:157)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.executeEngine(EngineExecutionOrchestrator.java:230)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.failOrExecuteEngine(EngineExecutionOrchestrator.java:204)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:172)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:101)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:64)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:150)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:63)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:109)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:91)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.junit.platform.launcher.core.InterceptingLauncher.lambda$execute$1(InterceptingLauncher.java:39)
	at org.junit.platform.launcher.core.ClasspathAlignmentCheckingLauncherInterceptor.intercept(ClasspathAlignmentCheckingLauncherInterceptor.java:25)
	at org.junit.platform.launcher.core.InterceptingLauncher.execute(InterceptingLauncher.java:38)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.apache.maven.surefire.junitplatform.LazyLauncher.execute(LazyLauncher.java:56)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.execute(JUnitPlatformProvider.java:194)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:150)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:122)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:385)
	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:507)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:495)
Caused by: software.amazon.awssdk.thirdparty.org.apache.http.NoHttpResponseException: The target server failed to respond
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
	at software.amazon.awssdk.thirdparty.org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
	at software.amazon.awssdk.thirdparty.org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
	at software.amazon.awssdk.http.apache.internal.impl.ApacheSdkHttpClient.execute(ApacheSdkHttpClient.java:72)
	at software.amazon.awssdk.http.apache.ApacheHttpClient.execute(ApacheHttpClient.java:261)
	at software.amazon.awssdk.http.apache.ApacheHttpClient.access$600(ApacheHttpClient.java:106)
	at software.amazon.awssdk.http.apache.ApacheHttpClient$1.call(ApacheHttpClient.java:238)
	at software.amazon.awssdk.http.apache.ApacheHttpClient$1.call(ApacheHttpClient.java:235)
	at software.amazon.awssdk.core.internal.util.MetricUtils.measureDurationUnsafe(MetricUtils.java:103)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.executeHttpRequest(MakeHttpRequestStage.java:88)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.execute(MakeHttpRequestStage.java:64)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.execute(MakeHttpRequestStage.java:46)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptTimeoutTrackingStage.execute(ApiCallAttemptTimeoutTrackingStage.java:74)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptTimeoutTrackingStage.execute(ApiCallAttemptTimeoutTrackingStage.java:43)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.TimeoutExceptionHandlingStage.execute(TimeoutExceptionHandlingStage.java:79)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.TimeoutExceptionHandlingStage.execute(TimeoutExceptionHandlingStage.java:41)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptMetricCollectionStage.execute(ApiCallAttemptMetricCollectionStage.java:55)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptMetricCollectionStage.execute(ApiCallAttemptMetricCollectionStage.java:39)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.executeRequest(RetryableStage.java:93)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:56)
	... 122 more
2025-09-17 18:43:48,586 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Retrying Request: DefaultSdkHttpFullRequest(httpMethod=PUT, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/testSDKMetricsCostOfGetFileStatusOnFile, headers=[amz-sdk-invocation-id, Content-Length, Content-Type, Expect, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:48,586 [setup] DEBUG impl.UploadContentProviders (UploadContentProviders.java:newStream(291)) - Stream recreated: ByteArrayContentProvider{buffer with length=33554432, offset=0} BaseContentProvider{size=0, initiated at 2025-09-17T18:43:48.553251, streamCreationCount=2, currentStream=null}
2025-09-17 18:43:48,888 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "PUT /test/testSDKMetricsCostOfGetFileStatusOnFile HTTP/1.1[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "amz-sdk-invocation-id: 6e900670-40a3-f6d4-29b0-6661d7811e52[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "amz-sdk-request: attempt=2; max=3[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-type;host;referer;x-amz-content-sha256;x-amz-date, Signature=fcdc23ddcd2b9ca5a76f340685f352e876898fbd2a28b837a420b7d99de30af7[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Content-Type: application/octet-stream[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Expect: 100-continue[\r][\n]"
2025-09-17 18:43:48,889 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Referer: https://audit.example.org/hadoop/1/op_create/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006/?op=op_create&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000006&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131028540[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB md/rb#u m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "X-Amz-Date: 20250917T174348Z[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Content-Length: 0[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:48,890 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "[\r][\n]"
2025-09-17 18:43:49,094 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:49,096 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "date: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:49,096 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:49,096 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-request-id: 017c7b17e100019958c6840d05098cdca4a99d0a[\r][\n]"
2025-09-17 18:43:49,097 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-id-2: b6aOSo8aLGfa2[\r][\n]"
2025-09-17 18:43:49,097 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "etag: "6036aaaf62444466bf0a21cc7518f738"[\r][\n]"
2025-09-17 18:43:49,097 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-expiration: NotImplemented[\r][\n]"
2025-09-17 18:43:49,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-server-side-encryption: AES256[\r][\n]"
2025-09-17 18:43:49,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-checksum-crc64nvme: AAAAAAAAAAA=[\r][\n]"
2025-09-17 18:43:49,098 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "x-amz-checksum-type: FULL_OBJECT[\r][\n]"
2025-09-17 18:43:49,099 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "transfer-encoding: chunked[\r][\n]"
2025-09-17 18:43:49,099 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "[\r][\n]"
2025-09-17 18:43:49,100 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 017c7b17e100019958c6840d05098cdca4a99d0a, Extended Request ID: b6aOSo8aLGfa2
2025-09-17 18:43:49,101 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "0[\r][\n]"
2025-09-17 18:43:49,101 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 << "[\r][\n]"
2025-09-17 18:43:49,102 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:incrementPutCompletedStatistics(527)) - PUT completed success=true; 0 bytes
2025-09-17 18:43:49,102 [setup] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - Writing Object: duration 0:00.548s
2025-09-17 18:43:49,102 [setup] DEBUG s3a.S3ADataBlocks (S3ADataBlocks.java:enterState(261)) - ByteArrayBlock{index=0, state=Upload, limit=33554432, dataSize=0}: entering state Closed
2025-09-17 18:43:49,102 [setup] DEBUG s3a.S3ADataBlocks (S3ADataBlocks.java:close(384)) - Closed ByteArrayBlock{index=0, state=Closed, limit=33554432, dataSize=0}
2025-09-17 18:43:49,102 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:close(554)) - Upload complete to test/testSDKMetricsCostOfGetFileStatusOnFile by WriteOperationHelper {bucket=stevel--usw2-az1--x-s3}
2025-09-17 18:43:49,107 [setup] DEBUG s3a.S3ABlockOutputStream (S3ABlockOutputStream.java:cleanupOnClose(586)) - Statistics: OutputStreamStatistics{counters=((multipart_upload_part_put.failures=0) (multipart_upload_completed.failures=0) (stream_write_exceptions=0) (op_hflush=0) (stream_write_total_data=0) (action_executor_acquired.failures=0) (object_multipart_aborted.failures=0) (committer_magic_marker_put.failures=0) (multipart_upload_part_put=0) (op_hsync=0) (op_abort.failures=0) (stream_write_exceptions_completing_upload=0) (conditional_create=0) (object_multipart_aborted=0) (action_executor_acquired=0) (stream_write_queue_duration=0) (conditional_create_failed=0) (object_put_request.failures=0) (object_multipart_initiated.failures=0) (op_abort=0) (stream_write_total_time=0) (committer_magic_marker_put=0) (object_put_request=1) (stream_write_bytes=0) (object_multipart_initiated=0) (stream_write_block_uploads=1) (multipart_upload_completed=0));
gauges=((stream_write_block_uploads_pending=0) (stream_write_block_uploads_active=0) (stream_write_block_uploads_data_pending=0));
minimums=((committer_magic_marker_put.min=-1) (multipart_upload_part_put.failures.min=-1) (multipart_upload_completed.failures.min=-1) (object_put_request.failures.min=-1) (object_multipart_aborted.min=-1) (committer_magic_marker_put.failures.min=-1) (multipart_upload_completed.min=-1) (object_multipart_initiated.failures.min=-1) (object_put_request.min=547) (action_executor_acquired.failures.min=-1) (op_abort.min=-1) (multipart_upload_part_put.min=-1) (action_executor_acquired.min=0) (object_multipart_aborted.failures.min=-1) (op_abort.failures.min=-1) (object_multipart_initiated.min=-1));
maximums=((object_multipart_aborted.max=-1) (object_multipart_initiated.failures.max=-1) (object_put_request.failures.max=-1) (object_multipart_aborted.failures.max=-1) (op_abort.max=-1) (committer_magic_marker_put.failures.max=-1) (multipart_upload_completed.max=-1) (object_multipart_initiated.max=-1) (action_executor_acquired.max=0) (object_put_request.max=547) (committer_magic_marker_put.max=-1) (multipart_upload_part_put.max=-1) (op_abort.failures.max=-1) (action_executor_acquired.failures.max=-1) (multipart_upload_completed.failures.max=-1) (multipart_upload_part_put.failures.max=-1));
means=((action_executor_acquired.mean=(samples=1, sum=0, mean=0.0000)) (object_multipart_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.failures.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_completed.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.mean=(samples=1, sum=547, mean=547.0000)) (committer_magic_marker_put.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_part_put.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_aborted.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_part_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_completed.failures.mean=(samples=0, sum=0, mean=0.0000)));
, blocksActive=0, blockUploadsCompleted=1, blocksAllocated=1, blocksReleased=1, blocksActivelyAllocated=0, transferDuration=548 ms, totalUploadDuration=548 ms, effectiveBandwidth=0.0 bytes/s}
2025-09-17 18:43:49,109 [setup] INFO  statistics.ITestAWSStatisticCollection (ITestAWSStatisticCollection.java:testSDKMetricsCostOfGetFileStatusOnFile(60)) - Initiating GET request for s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile
2025-09-17 18:43:49,311 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerGetFileStatus(3966)) - Getting path status for s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile  (test/testSDKMetricsCostOfGetFileStatusOnFile); needEmptyDirectory=false
2025-09-17 18:43:49,311 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4025)) - S3GetFileStatus s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile
2025-09-17 18:43:49,311 [setup] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:lambda$headObject$3(683)) - HEAD test/testSDKMetricsCostOfGetFileStatusOnFile with change tracker null
2025-09-17 18:43:49,312 [setup] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008 Executing op_get_file_status with {action_http_head_request 'test/testSDKMetricsCostOfGetFileStatusOnFile' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_get_file_status/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008/?op=op_get_file_status&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029311
2025-09-17 18:43:49,312 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=HEAD, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/testSDKMetricsCostOfGetFileStatusOnFile, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "HEAD /test/testSDKMetricsCostOfGetFileStatusOnFile HTTP/1.1[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "amz-sdk-invocation-id: 1804bbcd-04de-cba8-8055-6a09917ca20d[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=228a46bb1d008468d38afd0da0ed7b4c354ab12631a63bf4283cb23dc02527a3[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Referer: https://audit.example.org/hadoop/1/op_get_file_status/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008/?op=op_get_file_status&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029311[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:49,313 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:49,314 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "X-Amz-Date: 20250917T174349Z[\r][\n]"
2025-09-17 18:43:49,314 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:49,314 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-1 >> "[\r][\n]"
2025-09-17 18:43:49,314 [setup] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-1 << "end of stream"
2025-09-17 18:43:49,314 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(125)) - Retryable error detected. Will retry in 51ms. Request attempt number 1
software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: The target server failed to respond
	at software.amazon.awssdk.core.exception.SdkClientException$BuilderImpl.build(SdkClientException.java:130)
	at software.amazon.awssdk.core.exception.SdkClientException.create(SdkClientException.java:47)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.RetryableStageHelper.setLastException(RetryableStageHelper.java:231)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:65)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:36)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.StreamManagingStage.execute(StreamManagingStage.java:53)
	at software.amazon.awssdk.core.internal.http.StreamManagingStage.execute(StreamManagingStage.java:35)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.executeWithTimer(ApiCallTimeoutTrackingStage.java:82)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.execute(ApiCallTimeoutTrackingStage.java:62)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallTimeoutTrackingStage.execute(ApiCallTimeoutTrackingStage.java:43)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallMetricCollectionStage.execute(ApiCallMetricCollectionStage.java:50)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallMetricCollectionStage.execute(ApiCallMetricCollectionStage.java:32)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:37)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:26)
	at software.amazon.awssdk.core.internal.http.AmazonSyncHttpClient$RequestExecutionBuilderImpl.execute(AmazonSyncHttpClient.java:210)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.invoke(BaseSyncClientHandler.java:103)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.doExecute(BaseSyncClientHandler.java:173)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.lambda$execute$1(BaseSyncClientHandler.java:80)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.measureApiCallSuccess(BaseSyncClientHandler.java:182)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.execute(BaseSyncClientHandler.java:74)
	at software.amazon.awssdk.core.client.handler.SdkSyncClientHandler.execute(SdkSyncClientHandler.java:45)
	at software.amazon.awssdk.awscore.client.handler.AwsSyncClientHandler.execute(AwsSyncClientHandler.java:53)
	at software.amazon.awssdk.services.s3.DefaultS3Client.headObject(DefaultS3Client.java:7623)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.lambda$headObject$59(DelegatingS3Client.java:6180)
	at software.amazon.awssdk.services.s3.internal.crossregion.S3CrossRegionSyncClient.invokeOperation(S3CrossRegionSyncClient.java:67)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.headObject(DelegatingS3Client.java:6180)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.lambda$headObject$3(S3AStoreImpl.java:688)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.headObject(S3AStoreImpl.java:675)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3045)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3025)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:4040)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3968)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.lambda$getFileStatus$21(S3AFileSystem.java:3945)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.invokeTrackingDuration(IOStatisticsBinding.java:547)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.lambda$trackDurationOfOperation$5(IOStatisticsBinding.java:528)
	at org.apache.hadoop.fs.statistics.impl.IOStatisticsBinding.trackDuration(IOStatisticsBinding.java:449)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2874)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.trackDurationAndSpan(S3AFileSystem.java:2893)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getFileStatus(S3AFileSystem.java:3943)
	at org.apache.hadoop.fs.s3a.statistics.ITestAWSStatisticCollection.lambda$testSDKMetricsCostOfGetFileStatusOnFile$0(ITestAWSStatisticCollection.java:61)
	at org.apache.hadoop.fs.s3a.performance.OperationCostValidator.exec(OperationCostValidator.java:167)
	at org.apache.hadoop.fs.s3a.performance.AbstractS3ACostTest.verifyMetrics(AbstractS3ACostTest.java:276)
	at org.apache.hadoop.fs.s3a.statistics.ITestAWSStatisticCollection.testSDKMetricsCostOfGetFileStatusOnFile(ITestAWSStatisticCollection.java:61)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:568)
	at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:787)
	at org.junit.platform.commons.support.ReflectionSupport.invokeMethod(ReflectionSupport.java:478)
	at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
	at org.junit.jupiter.engine.extension.SameThreadTimeoutInvocation.proceed(SameThreadTimeoutInvocation.java:49)
	at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:161)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:152)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:91)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:112)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:94)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:93)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:87)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$4(TestMethodTestDescriptor.java:221)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:217)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:159)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:70)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:157)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.executeEngine(EngineExecutionOrchestrator.java:230)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.failOrExecuteEngine(EngineExecutionOrchestrator.java:204)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:172)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:101)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:64)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:150)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:63)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:109)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:91)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.junit.platform.launcher.core.InterceptingLauncher.lambda$execute$1(InterceptingLauncher.java:39)
	at org.junit.platform.launcher.core.ClasspathAlignmentCheckingLauncherInterceptor.intercept(ClasspathAlignmentCheckingLauncherInterceptor.java:25)
	at org.junit.platform.launcher.core.InterceptingLauncher.execute(InterceptingLauncher.java:38)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.apache.maven.surefire.junitplatform.LazyLauncher.execute(LazyLauncher.java:56)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.execute(JUnitPlatformProvider.java:194)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:150)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:122)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:385)
	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:507)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:495)
Caused by: software.amazon.awssdk.thirdparty.org.apache.http.NoHttpResponseException: The target server failed to respond
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
	at software.amazon.awssdk.thirdparty.org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
	at software.amazon.awssdk.thirdparty.org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
	at software.amazon.awssdk.thirdparty.org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
	at software.amazon.awssdk.http.apache.internal.impl.ApacheSdkHttpClient.execute(ApacheSdkHttpClient.java:72)
	at software.amazon.awssdk.http.apache.ApacheHttpClient.execute(ApacheHttpClient.java:261)
	at software.amazon.awssdk.http.apache.ApacheHttpClient.access$600(ApacheHttpClient.java:106)
	at software.amazon.awssdk.http.apache.ApacheHttpClient$1.call(ApacheHttpClient.java:238)
	at software.amazon.awssdk.http.apache.ApacheHttpClient$1.call(ApacheHttpClient.java:235)
	at software.amazon.awssdk.core.internal.util.MetricUtils.measureDurationUnsafe(MetricUtils.java:103)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.executeHttpRequest(MakeHttpRequestStage.java:88)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.execute(MakeHttpRequestStage.java:64)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.MakeHttpRequestStage.execute(MakeHttpRequestStage.java:46)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.RequestPipelineBuilder$ComposingRequestPipelineStage.execute(RequestPipelineBuilder.java:206)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptTimeoutTrackingStage.execute(ApiCallAttemptTimeoutTrackingStage.java:74)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptTimeoutTrackingStage.execute(ApiCallAttemptTimeoutTrackingStage.java:43)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.TimeoutExceptionHandlingStage.execute(TimeoutExceptionHandlingStage.java:79)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.TimeoutExceptionHandlingStage.execute(TimeoutExceptionHandlingStage.java:41)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptMetricCollectionStage.execute(ApiCallAttemptMetricCollectionStage.java:55)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ApiCallAttemptMetricCollectionStage.execute(ApiCallAttemptMetricCollectionStage.java:39)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.executeRequest(RetryableStage.java:93)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.RetryableStage.execute(RetryableStage.java:56)
	... 122 more
2025-09-17 18:43:49,371 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Retrying Request: DefaultSdkHttpFullRequest(httpMethod=HEAD, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/testSDKMetricsCostOfGetFileStatusOnFile, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:49,672 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "HEAD /test/testSDKMetricsCostOfGetFileStatusOnFile HTTP/1.1[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: 1804bbcd-04de-cba8-8055-6a09917ca20d[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=2; max=3[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=920d981fad319228c969f5df7f5c1a3c7e4d3c0e2f45ff53bba73e6cf47c5871[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_get_file_status/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008/?op=op_get_file_status&p1=test/testSDKMetricsCostOfGetFileStatusOnFile&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000008&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029311[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:49,673 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174349Z[\r][\n]"
2025-09-17 18:43:49,674 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:49,674 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 01869434dd00019958c6871b05090b3f875a3c90[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: 9GqfbNyMyUs6[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "etag: "6036aaaf62444466bf0a21cc7518f738"[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "accept-ranges: bytes[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "last-modified: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-storage-class: EXPRESS_ONEZONE[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-type: application/octet-stream[\r][\n]"
2025-09-17 18:43:49,859 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-server-side-encryption: AES256[\r][\n]"
2025-09-17 18:43:49,860 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-length: 0[\r][\n]"
2025-09-17 18:43:49,860 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-expiration: NotImplemented[\r][\n]"
2025-09-17 18:43:49,860 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:48 GMT[\r][\n]"
2025-09-17 18:43:49,860 [setup] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:49,860 [setup] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 01869434dd00019958c6871b05090b3f875a3c90, Extended Request ID: 9GqfbNyMyUs6
2025-09-17 18:43:49,867 [setup] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4041)) - Found exact file: normal file test/testSDKMetricsCostOfGetFileStatusOnFile
2025-09-17 18:43:49,868 [setup] INFO  performance.OperationCostValidator (OperationCostValidator.java:exec(172)) - operation returning S3AFileStatus{path=s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile; isDirectory=false; length=0; replication=1; blocksize=33554432; modification_time=1758131029000; access_time=0; owner=stevel; group=stevel; permission=rw-rw-rw-; isSymlink=false; hasAcl=false; isEncrypted=true; isErasureCoded=false} isEmptyDirectory=FALSE eTag="6036aaaf62444466bf0a21cc7518f738" versionId=null
2025-09-17 18:43:49,868 [setup] INFO  performance.OperationCostValidator (OperationCostValidator.java:exec(173)) - state action_executor_acquired starting=0 current=0 diff=0, action_file_opened starting=0 current=0 diff=0, action_http_get_request starting=0 current=0 diff=0, action_http_head_request starting=1 current=2 diff=1, analytics_stream_factory_closed starting=0 current=0 diff=0, audit_access_check_failure starting=0 current=0 diff=0, audit_failure starting=0 current=0 diff=0, audit_request_execution starting=4 current=5 diff=1, audit_span_creation starting=4 current=5 diff=1, committer_bytes_committed starting=0 current=0 diff=0, committer_bytes_uploaded starting=0 current=0 diff=0, committer_commit_job starting=0 current=0 diff=0, committer_commits.failures starting=0 current=0 diff=0, committer_commits_aborted starting=0 current=0 diff=0, committer_commits_completed starting=0 current=0 diff=0, committer_commits_created starting=0 current=0 diff=0, committer_commits_reverted starting=0 current=0 diff=0, committer_jobs_completed starting=0 current=0 diff=0, committer_jobs_failed starting=0 current=0 diff=0, committer_load_single_pending_file starting=0 current=0 diff=0, committer_magic_files_created starting=0 current=0 diff=0, committer_magic_marker_put starting=0 current=0 diff=0, committer_materialize_file starting=0 current=0 diff=0, committer_stage_file_upload starting=0 current=0 diff=0, committer_tasks_completed starting=0 current=0 diff=0, committer_tasks_failed starting=0 current=0 diff=0, conditional_create starting=0 current=0 diff=0, conditional_create_failed starting=0 current=0 diff=0, delegation_tokens_issued starting=0 current=0 diff=0, directories_created starting=1 current=1 diff=0, directories_deleted starting=0 current=0 diff=0, fake_directories_created starting=0 current=0 diff=0, fake_directories_deleted starting=0 current=0 diff=0, files_copied starting=0 current=0 diff=0, files_copied_bytes starting=0 current=0 diff=0, files_created starting=1 current=1 diff=0, files_delete_rejected starting=0 current=0 diff=0, files_deleted starting=0 current=0 diff=0, filesystem_close starting=0 current=0 diff=0, filesystem_initialization starting=1 current=1 diff=0, http_response_400 starting=0 current=0 diff=0, http_response_429 starting=0 current=0 diff=0, http_response_4XX starting=0 current=0 diff=0, http_response_500 starting=0 current=0 diff=0, http_response_503 starting=0 current=0 diff=0, http_response_5XX starting=0 current=0 diff=0, ignored_errors starting=0 current=0 diff=0, multipart_instantiated starting=0 current=0 diff=0, multipart_upload_abort_under_path_invoked starting=0 current=0 diff=0, multipart_upload_aborted starting=0 current=0 diff=0, multipart_upload_completed starting=0 current=0 diff=0, multipart_upload_list starting=0 current=0 diff=0, multipart_upload_part_put starting=0 current=0 diff=0, multipart_upload_part_put_bytes starting=0 current=0 diff=0, multipart_upload_started starting=0 current=0 diff=0, object_bulk_delete_request starting=0 current=0 diff=0, object_continue_list_request starting=0 current=0 diff=0, object_copy_requests starting=0 current=0 diff=0, object_delete_objects starting=0 current=0 diff=0, object_delete_request starting=0 current=0 diff=0, object_list_request starting=1 current=1 diff=0, object_metadata_request starting=1 current=2 diff=1, object_multipart_aborted starting=0 current=0 diff=0, object_multipart_initiated starting=0 current=0 diff=0, object_multipart_list starting=0 current=0 diff=0, object_put_bytes starting=0 current=0 diff=0, object_put_request starting=1 current=1 diff=0, object_put_request_completed starting=2 current=2 diff=0, op_abort starting=0 current=0 diff=0, op_access starting=0 current=0 diff=0, op_bulk-delete starting=0 current=0 diff=0, op_copy_from_local_file starting=0 current=0 diff=0, op_create starting=1 current=1 diff=0, op_create_non_recursive starting=0 current=0 diff=0, op_createfile starting=0 current=0 diff=0, op_delete starting=0 current=0 diff=0, op_exists starting=0 current=0 diff=0, op_get_content_summary starting=0 current=0 diff=0, op_get_delegation_token starting=0 current=0 diff=0, op_get_file_checksum starting=0 current=0 diff=0, op_get_file_status starting=0 current=1 diff=1, op_glob_status starting=0 current=0 diff=0, op_hflush starting=0 current=0 diff=0, op_hsync starting=0 current=0 diff=0, op_is_directory starting=0 current=0 diff=0, op_is_file starting=0 current=0 diff=0, op_list_files starting=0 current=0 diff=0, op_list_located_status starting=0 current=0 diff=0, op_list_status starting=0 current=0 diff=0, op_mkdirs starting=1 current=1 diff=0, op_open starting=0 current=0 diff=0, op_openfile starting=0 current=0 diff=0, op_rename starting=0 current=0 diff=0, op_xattr_get_map starting=0 current=0 diff=0, op_xattr_get_named starting=0 current=0 diff=0, op_xattr_get_named_map starting=0 current=0 diff=0, op_xattr_list starting=0 current=0 diff=0, store_client_creation starting=1 current=1 diff=0, store_exists_probe starting=0 current=0 diff=0, store_io_rate_limited_duration starting=0 current=0 diff=0, store_io_request starting=5 current=7 diff=2, store_io_retry starting=1 current=2 diff=1, store_io_throttled starting=0 current=0 diff=0, stream_aborted starting=0 current=0 diff=0, stream_evict_blocks_from_cache starting=0 current=0 diff=0, stream_file_cache_eviction starting=0 current=0 diff=0, stream_leaks starting=0 current=0 diff=0, stream_read_analytics_opened starting=0 current=0 diff=0, stream_read_bytes starting=0 current=0 diff=0, stream_read_bytes_backwards_on_seek starting=0 current=0 diff=0, stream_read_bytes_discarded_in_abort starting=0 current=0 diff=0, stream_read_bytes_discarded_in_close starting=0 current=0 diff=0, stream_read_close_operations starting=0 current=0 diff=0, stream_read_closed starting=0 current=0 diff=0, stream_read_exceptions starting=0 current=0 diff=0, stream_read_fully_operations starting=0 current=0 diff=0, stream_read_opened starting=0 current=0 diff=0, stream_read_operations starting=0 current=0 diff=0, stream_read_operations_incomplete starting=0 current=0 diff=0, stream_read_remote_stream_aborted starting=0 current=0 diff=0, stream_read_remote_stream_drain starting=0 current=0 diff=0, stream_read_seek_backward_operations starting=0 current=0 diff=0, stream_read_seek_bytes_discarded starting=0 current=0 diff=0, stream_read_seek_bytes_skipped starting=0 current=0 diff=0, stream_read_seek_forward_operations starting=0 current=0 diff=0, stream_read_seek_operations starting=0 current=0 diff=0, stream_read_seek_policy_changed starting=0 current=0 diff=0, stream_read_total_bytes starting=0 current=0 diff=0, stream_read_unbuffered starting=0 current=0 diff=0, stream_read_vectored_combined_ranges starting=0 current=0 diff=0, stream_read_vectored_incoming_ranges starting=0 current=0 diff=0, stream_read_vectored_operations starting=0 current=0 diff=0, stream_read_vectored_read_bytes_discarded starting=0 current=0 diff=0, stream_read_version_mismatches starting=0 current=0 diff=0, stream_write_block_uploads starting=1 current=1 diff=0, stream_write_block_uploads_aborted starting=0 current=0 diff=0, stream_write_block_uploads_committed starting=0 current=0 diff=0, stream_write_bytes starting=0 current=0 diff=0, stream_write_exceptions starting=0 current=0 diff=0, stream_write_exceptions_completing_upload starting=0 current=0 diff=0, stream_write_queue_duration starting=0 current=0 diff=0, stream_write_total_data starting=0 current=0 diff=0, stream_write_total_time starting=548 current=548 diff=0
2025-09-17 18:43:49,868 [setup] INFO  performance.OperationCostValidator (OperationCostValidator.java:exec(174)) - probes [ExpectSingleStatistic{store_io_request, expected=1, enabled=true}]
2025-09-17 18:43:49,871 [setup] INFO  performance.OperationCostValidator (OperationCostValidator.java:exec(175)) - IOStatistics counters=((action_http_head_request=2)
(audit_request_execution=5)
(audit_span_creation=5)
(directories_created=1)
(files_created=1)
(filesystem_initialization=1)
(object_list_request=1)
(object_metadata_request=2)
(object_put_request=2)
(object_put_request_completed=2)
(op_create=1)
(op_get_file_status=1)
(op_mkdirs=1)
(store_client_creation=1)
(store_io_request=7)
(store_io_retry=2)
(stream_write_block_uploads=2)
(stream_write_total_time=548));

gauges=();

minimums=((action_executor_acquired.min=0)
(action_http_head_request.min=170)
(filesystem_initialization.min=364)
(object_list_request.min=845)
(object_put_request.min=547)
(op_create.min=10)
(op_get_file_status.min=557)
(op_mkdirs.min=1228)
(store_client_creation.min=295));

maximums=((action_executor_acquired.max=0)
(action_http_head_request.max=556)
(filesystem_initialization.max=364)
(object_list_request.max=845)
(object_put_request.max=547)
(op_create.max=10)
(op_get_file_status.max=557)
(op_mkdirs.max=1228)
(store_client_creation.max=295));

means=((action_executor_acquired.mean=(samples=1, sum=0, mean=0.0000))
(action_http_head_request.mean=(samples=2, sum=726, mean=363.0000))
(filesystem_initialization.mean=(samples=1, sum=364, mean=364.0000))
(object_list_request.mean=(samples=1, sum=845, mean=845.0000))
(object_put_request.mean=(samples=2, sum=730, mean=365.0000))
(op_create.mean=(samples=1, sum=10, mean=10.0000))
(op_get_file_status.mean=(samples=1, sum=557, mean=557.0000))
(op_mkdirs.mean=(samples=1, sum=1228, mean=1228.0000))
(store_client_creation.mean=(samples=1, sum=295, mean=295.0000)));

2025-09-17 18:43:49,872 [setup] ERROR s3a.S3ATestUtils (S3ATestUtils.java:assertDiffEquals(1282)) - operation returning S3AFileStatus{path=s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile; isDirectory=false; length=0; replication=1; blocksize=33554432; modification_time=1758131029000; access_time=0; owner=stevel; group=stevel; permission=rw-rw-rw-; isSymlink=false; hasAcl=false; isEncrypted=true; isErasureCoded=false} isEmptyDirectory=FALSE eTag="6036aaaf62444466bf0a21cc7518f738" versionId=null: store_io_request expected 1, actual 2
2025-09-17 18:43:49,878 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerGetFileStatus(3966)) - Getting path status for s3a://stevel--usw2-az1--x-s3/test  (test); needEmptyDirectory=true
2025-09-17 18:43:49,878 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4025)) - S3GetFileStatus s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:49,878 [teardown] DEBUG impl.S3AStoreImpl (S3AStoreImpl.java:lambda$headObject$3(683)) - HEAD test with change tracker null
2025-09-17 18:43:49,879 [teardown] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {action_http_head_request 'test' size=0, mutating=false}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029877
2025-09-17 18:43:49,880 [teardown] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=HEAD, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:49,881 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "HEAD /test HTTP/1.1[\r][\n]"
2025-09-17 18:43:49,881 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: d091cc9b-aee7-2c3a-f2d0-f947476da054[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=980af30ea33bac18dbf03bca180be471bc480a4e32a5d1bd09144b1110cf703f[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029877[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174349Z[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:49,882 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:50,034 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 404 Not Found[\r][\n]"
2025-09-17 18:43:50,036 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:50,036 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,036 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 0188817baa00019958c687ec05097bc52e757f6f[\r][\n]"
2025-09-17 18:43:50,036 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: axb11Zw[\r][\n]"
2025-09-17 18:43:50,036 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:50,037 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:50,038 [teardown] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received failed response: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw
2025-09-17 18:43:50,040 [teardown] DEBUG s3a.Invoker (Invoker.java:retryUntranslated(474)) - HEAD test ; software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw), 
2025-09-17 18:43:50,040 [teardown] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:shouldRetry(318)) - Retry probe for FileNotFoundException with 0 retries and 0 failovers, idempotent=true, due to java.io.FileNotFoundException: HEAD test on /: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw):NoSuchKey
java.io.FileNotFoundException: HEAD test on /: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw):NoSuchKey
	at org.apache.hadoop.fs.s3a.S3AUtils.translateException(S3AUtils.java:283)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:481)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:431)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.headObject(S3AStoreImpl.java:675)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3045)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.getObjectMetadata(S3AFileSystem.java:3025)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.s3GetFileStatus(S3AFileSystem.java:4040)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.innerGetFileStatus(S3AFileSystem.java:3968)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.deleteWithoutCloseCheck(S3AFileSystem.java:3567)
	at org.apache.hadoop.fs.s3a.S3AFileSystem.delete(S3AFileSystem.java:3539)
	at org.apache.hadoop.fs.contract.ContractTestUtils.rm(ContractTestUtils.java:471)
	at org.apache.hadoop.fs.contract.ContractTestUtils.cleanup(ContractTestUtils.java:448)
	at org.apache.hadoop.fs.contract.AbstractFSContractTestBase.deleteTestDirInTeardown(AbstractFSContractTestBase.java:221)
	at org.apache.hadoop.fs.contract.AbstractFSContractTestBase.teardown(AbstractFSContractTestBase.java:209)
	at org.apache.hadoop.fs.s3a.AbstractS3ATestBase.teardown(AbstractS3ATestBase.java:123)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:568)
	at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:787)
	at org.junit.platform.commons.support.ReflectionSupport.invokeMethod(ReflectionSupport.java:478)
	at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131)
	at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:161)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptLifecycleMethod(TimeoutExtension.java:133)
	at org.junit.jupiter.engine.extension.TimeoutExtension.interceptAfterEachMethod(TimeoutExtension.java:115)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:112)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:94)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45)
	at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:93)
	at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:87)
	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.invokeMethodInExtensionContext(ClassBasedTestDescriptor.java:547)
	at org.junit.jupiter.engine.descriptor.ClassBasedTestDescriptor.lambda$synthesizeAfterEachMethodAdapter$21(ClassBasedTestDescriptor.java:537)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeAfterEachMethods$6(TestMethodTestDescriptor.java:246)
	at org.junit.jupiter.engine.descriptor.CallbackSupport.lambda$invokeAfterCallbacks$1(CallbackSupport.java:49)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.jupiter.engine.descriptor.CallbackSupport.lambda$invokeAfterCallbacks$2(CallbackSupport.java:49)
	at org.junit.platform.commons.util.CollectionUtils.forEachInReverseOrder(CollectionUtils.java:259)
	at org.junit.jupiter.engine.descriptor.CallbackSupport.invokeAfterCallbacks(CallbackSupport.java:48)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeAfterEachMethods(TestMethodTestDescriptor.java:244)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:163)
	at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:70)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:157)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:161)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:147)
	at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:145)
	at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:144)
	at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:101)
	at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
	at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.executeEngine(EngineExecutionOrchestrator.java:230)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.failOrExecuteEngine(EngineExecutionOrchestrator.java:204)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:172)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:101)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:64)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:150)
	at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:63)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:109)
	at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:91)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.junit.platform.launcher.core.InterceptingLauncher.lambda$execute$1(InterceptingLauncher.java:39)
	at org.junit.platform.launcher.core.ClasspathAlignmentCheckingLauncherInterceptor.intercept(ClasspathAlignmentCheckingLauncherInterceptor.java:25)
	at org.junit.platform.launcher.core.InterceptingLauncher.execute(InterceptingLauncher.java:38)
	at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47)
	at org.apache.maven.surefire.junitplatform.LazyLauncher.execute(LazyLauncher.java:56)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.execute(JUnitPlatformProvider.java:194)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:150)
	at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:122)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:385)
	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:507)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:495)
Caused by: software.amazon.awssdk.services.s3.model.NoSuchKeyException: (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw) (SDK Attempt Count: 1) (Service: S3, Status Code: 404, Request ID: 0188817baa00019958c687ec05097bc52e757f6f, Extended Request ID: axb11Zw)
	at software.amazon.awssdk.services.s3.model.NoSuchKeyException$BuilderImpl.build(NoSuchKeyException.java:150)
	at software.amazon.awssdk.services.s3.model.NoSuchKeyException$BuilderImpl.build(NoSuchKeyException.java:98)
	at software.amazon.awssdk.services.s3.internal.handlers.ExceptionTranslationInterceptor.modifyException(ExceptionTranslationInterceptor.java:65)
	at software.amazon.awssdk.core.interceptor.ExecutionInterceptorChain.modifyException(ExecutionInterceptorChain.java:181)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.ExceptionReportingUtils.runModifyException(ExceptionReportingUtils.java:54)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.utils.ExceptionReportingUtils.reportFailureToInterceptors(ExceptionReportingUtils.java:38)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:39)
	at software.amazon.awssdk.core.internal.http.pipeline.stages.ExecutionFailureExceptionReportingStage.execute(ExecutionFailureExceptionReportingStage.java:26)
	at software.amazon.awssdk.core.internal.http.AmazonSyncHttpClient$RequestExecutionBuilderImpl.execute(AmazonSyncHttpClient.java:210)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.invoke(BaseSyncClientHandler.java:103)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.doExecute(BaseSyncClientHandler.java:173)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.lambda$execute$1(BaseSyncClientHandler.java:80)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.measureApiCallSuccess(BaseSyncClientHandler.java:182)
	at software.amazon.awssdk.core.internal.handler.BaseSyncClientHandler.execute(BaseSyncClientHandler.java:74)
	at software.amazon.awssdk.core.client.handler.SdkSyncClientHandler.execute(SdkSyncClientHandler.java:45)
	at software.amazon.awssdk.awscore.client.handler.AwsSyncClientHandler.execute(AwsSyncClientHandler.java:53)
	at software.amazon.awssdk.services.s3.DefaultS3Client.headObject(DefaultS3Client.java:7623)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.lambda$headObject$59(DelegatingS3Client.java:6180)
	at software.amazon.awssdk.services.s3.internal.crossregion.S3CrossRegionSyncClient.invokeOperation(S3CrossRegionSyncClient.java:67)
	at software.amazon.awssdk.services.s3.DelegatingS3Client.headObject(DelegatingS3Client.java:6180)
	at org.apache.hadoop.fs.s3a.impl.S3AStoreImpl.lambda$headObject$3(S3AStoreImpl.java:688)
	at org.apache.hadoop.fs.s3a.Invoker.retryUntranslated(Invoker.java:468)
	... 96 more
2025-09-17 18:43:50,042 [teardown] DEBUG s3a.S3ARetryPolicy (S3ARetryPolicy.java:shouldRetry(323)) - Retry action is RetryAction(action=FAIL, delayMillis=0, reason=try once and fail.)
2025-09-17 18:43:50,042 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:listObjects(3084)) - LIST List stevel--usw2-az1--x-s3:/test/ delimiter=/ keys=2 requester pays=null
2025-09-17 18:43:50,042 [teardown] DEBUG s3a.S3AFileSystem (DurationInfo.java:<init>(80)) - Starting: LIST
2025-09-17 18:43:50,044 [teardown] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [1] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {object_list_request 'test/' size=2, mutating=false}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029877
2025-09-17 18:43:50,045 [teardown] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=GET, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[list-type, delimiter, max-keys, prefix])
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "GET /?list-type=2&delimiter=%2F&max-keys=2&prefix=test%2F HTTP/1.1[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: 2403b167-b076-67de-b03c-c9a482ff4ac8[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=d7871ef99d42c69729a41d6b7deb854cf5f74ef16bedcc04ced36602de95e084[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=1&ts=1758131029877[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:50,047 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:50,048 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174350Z[\r][\n]"
2025-09-17 18:43:50,048 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:50,048 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:50,224 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:50,224 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,224 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 017cdad55500019958c6889205098b28f926bb39[\r][\n]"
2025-09-17 18:43:50,224 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: zoOpFWLch[\r][\n]"
2025-09-17 18:43:50,224 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:50,225 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-length: 904[\r][\n]"
2025-09-17 18:43:50,225 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-bucket-region: us-west-2[\r][\n]"
2025-09-17 18:43:50,225 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:50,225 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:50,226 [teardown] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "<?xml version="1.0" encoding="UTF-8"?>[\n]"
2025-09-17 18:43:50,226 [teardown] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-2 << "<ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>stevel--usw2-az1--x-s3</Name><Prefix>test/</Prefix><KeyCount>2</KeyCount><MaxKeys>2</MaxKeys><IsTruncated>false</IsTruncated><Contents><ChecksumAlgorithm>CRC64NVME</ChecksumAlgorithm><ETag>&quot;927605342e6d4d38b420a5b420523775&quot;</ETag><Key>test/</Key><LastModified>2025-09-17T17:43:48.000Z</LastModified><Size>0</Size><StorageClass>EXPRESS_ONEZONE</StorageClass><ChecksumType>FULL_OBJECT</ChecksumType></Contents><Contents><ChecksumAlgorithm>CRC64NVME</ChecksumAlgorithm><ETag>&quot;6036aaaf62444466bf0a21cc7518f738&quot;</ETag><Key>test/testSDKMetricsCostOfGetFileStatusOnFile</Key><LastModified>2025-09-17T17:43:49.000Z</LastModified><Size>0</Size><StorageClass>EXPRESS_ONEZONE</StorageClass><ChecksumType>FULL_OBJECT</ChecksumType></Contents><Delimiter>/</Delimiter></ListBucketResult>"
2025-09-17 18:43:50,227 [teardown] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 017cdad55500019958c6889205098b28f926bb39, Extended Request ID: zoOpFWLch
2025-09-17 18:43:50,233 [teardown] DEBUG s3a.S3AFileSystem (DurationInfo.java:close(101)) - LIST: duration 0:00.191s
2025-09-17 18:43:50,233 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:s3GetFileStatus(4082)) - Found path as directory (with /)
2025-09-17 18:43:50,233 [teardown] DEBUG s3a.S3AFileSystem (S3ListResult.java:logAtDebug(146)) - Prefix count = 0; object count=2
2025-09-17 18:43:50,233 [teardown] DEBUG s3a.S3AFileSystem (S3ListResult.java:logAtDebug(149)) - Summary: test/ 0
2025-09-17 18:43:50,234 [teardown] DEBUG s3a.S3AFileSystem (S3ListResult.java:logAtDebug(149)) - Summary: test/testSDKMetricsCostOfGetFileStatusOnFile 0
2025-09-17 18:43:50,235 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:execute(196)) - Delete path s3a://stevel--usw2-az1--x-s3/test - recursive true
2025-09-17 18:43:50,235 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:execute(197)) - Type = Directory
2025-09-17 18:43:50,235 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:execute(205)) - delete: Path is a directory: s3a://stevel--usw2-az1--x-s3/test
2025-09-17 18:43:50,235 [teardown] DEBUG impl.DeleteOperation (DurationInfo.java:<init>(80)) - Starting: deleting test/
2025-09-17 18:43:50,235 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:deleteDirectoryTree(267)) - All uploads under test/ will be deleted
2025-09-17 18:43:50,237 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:deleteDirectoryTree(279)) - Getting objects for directory prefix test/ to delete
2025-09-17 18:43:50,237 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:innerListFiles(5139)) - listFiles(s3a://stevel--usw2-az1--x-s3/test, true)
2025-09-17 18:43:50,238 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:getListFilesAssumingDir(206)) - Recursive list of all entries under test/
2025-09-17 18:43:50,240 [teardown] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: listObjects()
2025-09-17 18:43:50,240 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:listObjects(3084)) - LIST List stevel--usw2-az1--x-s3:/test/ delimiter=null keys=5000 requester pays=null
2025-09-17 18:43:50,240 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG s3a.S3AFileSystem (DurationInfo.java:<init>(80)) - Starting: LIST
2025-09-17 18:43:50,241 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [39] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {object_list_request 'test/' size=5000, mutating=false}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=39&ts=1758131029877
2025-09-17 18:43:50,241 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=GET, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[list-type, max-keys, prefix])
2025-09-17 18:43:50,241 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG s3a.MultipartUtils (MultipartUtils.java:requestNextBatch(192)) - [0], Requesting next 5000 uploads prefix test/, next key null, next upload id null
2025-09-17 18:43:50,242 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: listMultipartUploads
2025-09-17 18:43:50,242 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "GET /?list-type=2&max-keys=5000&prefix=test%2F HTTP/1.1[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: 26448357-6e00-b900-5402-bfce3fa1ffe5[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=39354672907491f00573205ec1753a5353714995c13f999b1cf1451d36838f7f[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=39&ts=1758131029877[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174350Z[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:50,243 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:50,244 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [38] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {multipart_upload_list 'test/' size=5000, mutating=false}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=38&ts=1758131029877
2025-09-17 18:43:50,245 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=GET, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[uploads, max-uploads, prefix])
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 017d107b7400019958c68951050985ccb3097134[\r][\n]"
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: BG7l4GV2GUae4qgXn[\r][\n]"
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:50,393 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "content-length: 883[\r][\n]"
2025-09-17 18:43:50,394 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-bucket-region: us-west-2[\r][\n]"
2025-09-17 18:43:50,394 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:50,394 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:50,395 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "<?xml version="1.0" encoding="UTF-8"?>[\n]"
2025-09-17 18:43:50,395 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-2 << "<ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>stevel--usw2-az1--x-s3</Name><Prefix>test/</Prefix><KeyCount>2</KeyCount><MaxKeys>5000</MaxKeys><IsTruncated>false</IsTruncated><Contents><ChecksumAlgorithm>CRC64NVME</ChecksumAlgorithm><ETag>&quot;927605342e6d4d38b420a5b420523775&quot;</ETag><Key>test/</Key><LastModified>2025-09-17T17:43:48.000Z</LastModified><Size>0</Size><StorageClass>EXPRESS_ONEZONE</StorageClass><ChecksumType>FULL_OBJECT</ChecksumType></Contents><Contents><ChecksumAlgorithm>CRC64NVME</ChecksumAlgorithm><ETag>&quot;6036aaaf62444466bf0a21cc7518f738&quot;</ETag><Key>test/testSDKMetricsCostOfGetFileStatusOnFile</Key><LastModified>2025-09-17T17:43:49.000Z</LastModified><Size>0</Size><StorageClass>EXPRESS_ONEZONE</StorageClass><ChecksumType>FULL_OBJECT</ChecksumType></Contents></ListBucketResult>"
2025-09-17 18:43:50,397 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 017d107b7400019958c68951050985ccb3097134, Extended Request ID: BG7l4GV2GUae4qgXn
2025-09-17 18:43:50,398 [s3a-transfer-stevel--usw2-az1--x-s3-unbounded-pool3-t1] DEBUG s3a.S3AFileSystem (DurationInfo.java:close(101)) - LIST: duration 0:00.158s
2025-09-17 18:43:50,398 [teardown] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - listObjects(): duration 0:00.158s
2025-09-17 18:43:50,399 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:buildNextStatusBatch(465)) - s3a://stevel--usw2-az1--x-s3/test: "test/" size=0
2025-09-17 18:43:50,399 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:buildNextStatusBatch(473)) - Adding: S3AFileStatus{path=s3a://stevel--usw2-az1--x-s3/test; isDirectory=true; modification_time=0; access_time=0; owner=stevel; group=stevel; permission=rwxrwxrwx; isSymlink=false; hasAcl=false; isEncrypted=true; isErasureCoded=false} isEmptyDirectory=UNKNOWN eTag=null versionId=null
2025-09-17 18:43:50,399 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:buildNextStatusBatch(465)) - s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile: "test/testSDKMetricsCostOfGetFileStatusOnFile" size=0
2025-09-17 18:43:50,399 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:buildNextStatusBatch(473)) - Adding: S3AFileStatus{path=s3a://stevel--usw2-az1--x-s3/test/testSDKMetricsCostOfGetFileStatusOnFile; isDirectory=false; length=0; replication=1; blocksize=33554432; modification_time=1758131029000; access_time=0; owner=stevel; group=stevel; permission=rw-rw-rw-; isSymlink=false; hasAcl=false; isEncrypted=true; isErasureCoded=false} isEmptyDirectory=FALSE eTag="6036aaaf62444466bf0a21cc7518f738" versionId=null
2025-09-17 18:43:50,399 [teardown] DEBUG s3a.S3AFileSystem (Listing.java:buildNextStatusBatch(503)) - Added 2 entries; ignored 0; hasNext=true; hasMoreObjects=false
2025-09-17 18:43:50,402 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:queueForDeletion(334)) - Adding object to delete: "test/"
2025-09-17 18:43:50,405 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:queueForDeletion(334)) - Adding object to delete: "test/testSDKMetricsCostOfGetFileStatusOnFile"
2025-09-17 18:43:50,405 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:deleteDirectoryTree(292)) - Deleting final batch of listed files
2025-09-17 18:43:50,406 [teardown] DEBUG impl.CallableSupplier (DurationInfo.java:<init>(80)) - Starting: Waiting for task completion
2025-09-17 18:43:50,406 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.DeleteOperation (DurationInfo.java:<init>(80)) - Starting: Delete page of 2 keys
2025-09-17 18:43:50,406 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.DeleteOperation (DeleteOperation.java:asyncDeleteAction(430)) - Deleting of 1 file objects
2025-09-17 18:43:50,406 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: Remove S3 Files
2025-09-17 18:43:50,407 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.S3AFileSystem (DurationInfo.java:<init>(80)) - Starting: Deleting 1 keys
2025-09-17 18:43:50,409 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.S3AStoreImpl (DurationInfo.java:<init>(80)) - Starting: deleting test/testSDKMetricsCostOfGetFileStatusOnFile
2025-09-17 18:43:50,411 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [40] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {object_delete_request 'test/testSDKMetricsCostOfGetFileStatusOnFile' size=1, mutating=true}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&ks=1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=40&ts=1758131029877
2025-09-17 18:43:50,411 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=DELETE, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/testSDKMetricsCostOfGetFileStatusOnFile, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "DELETE /test/testSDKMetricsCostOfGetFileStatusOnFile HTTP/1.1[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: 0fc71b39-285e-cdb6-47bd-88a20a37e917[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=3178afdfca88a3b9367291517f44ffdeacc822c210b94fb6859b98ae9f555e35[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&ks=1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=40&ts=1758131029877[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174350Z[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:50,412 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "GET /?uploads&max-uploads=5000&prefix=test%2F HTTP/1.1[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "amz-sdk-invocation-id: 225cd78e-972e-4a2b-b119-71c8b57b55e2[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=5cc291358f69ab3600ee6fe7e246a0629108d22b7b8be0397f683b058a4eb802[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=38&ts=1758131029877[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "X-Amz-Date: 20250917T174350Z[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:50,546 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 >> "[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 204 No Content[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 01b9ed9aa900019958c689fe0509a9c34d411895[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: 8rKyb2B[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:49 GMT[\r][\n]"
2025-09-17 18:43:50,569 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:50,570 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 204, Request ID: 01b9ed9aa900019958c689fe0509a9c34d411895, Extended Request ID: 8rKyb2B
2025-09-17 18:43:50,571 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.S3AStoreImpl (DurationInfo.java:close(101)) - deleting test/testSDKMetricsCostOfGetFileStatusOnFile: duration 0:00.162s
2025-09-17 18:43:50,571 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.S3AFileSystem (DurationInfo.java:close(101)) - Deleting 1 keys: duration 0:00.164s
2025-09-17 18:43:50,571 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - Remove S3 Files: duration 0:00.165s
2025-09-17 18:43:50,571 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.DeleteOperation (DeleteOperation.java:asyncDeleteAction(443)) - Deleting 1 directory markers
2025-09-17 18:43:50,571 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.Invoker (DurationInfo.java:<init>(80)) - Starting: Remove S3 Dir Markers
2025-09-17 18:43:50,572 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.S3AFileSystem (DurationInfo.java:<init>(80)) - Starting: Deleting 1 keys
2025-09-17 18:43:50,572 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.S3AStoreImpl (DurationInfo.java:<init>(80)) - Starting: deleting test/
2025-09-17 18:43:50,572 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.LoggingAuditor (LoggingAuditor.java:modifyHttpRequest(404)) - [40] cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009 Executing op_delete with {object_delete_request 'test/' size=1, mutating=true}; https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&ks=1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=40&ts=1758131029877
2025-09-17 18:43:50,573 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Sending Request: DefaultSdkHttpFullRequest(httpMethod=DELETE, protocol=https, host=stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com, encodedPath=/test/, headers=[amz-sdk-invocation-id, Referer, User-Agent], queryParameters=[])
2025-09-17 18:43:50,573 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "DELETE /test/ HTTP/1.1[\r][\n]"
2025-09-17 18:43:50,573 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Host: stevel--usw2-az1--x-s3.s3express-usw2-az1.us-west-2.amazonaws.com[\r][\n]"
2025-09-17 18:43:50,573 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-invocation-id: d2f0b3b9-7329-ae87-b4f6-682dd539369b[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "amz-sdk-request: attempt=1; max=3[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Authorization: AWS4-HMAC-SHA256 Credential=AKIA/20250917/us-west-2/s3express/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;host;referer;x-amz-content-sha256;x-amz-date, Signature=0c262d8a747f45a7132a357125542ed846b34f117a228180d7825449aeb9cef5[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Referer: https://audit.example.org/hadoop/1/op_delete/cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009/?op=op_delete&p1=s3a://stevel--usw2-az1--x-s3/test&pr=stevel&ps=282e3c5d-c1bd-4859-94b9-82e77ff225d1&ks=1&id=cf739331-1f2e-42dd-a5d9-f564d6023a23-00000009&t0=1&fs=cf739331-1f2e-42dd-a5d9-f564d6023a23&t1=40&ts=1758131029877[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "User-Agent: Hadoop 3.5.0-SNAPSHOT aws-sdk-java/2.33.8 md/io#sync md/http#Apache ua/2.1 api/S3#2.33.x os/Mac_OS_X#15.6.1 lang/java#17.0.8 md/OpenJDK_64-Bit_Server_VM#17.0.8+7-LTS md/vendor#Amazon.com_Inc. md/en_GB m/F,G hll/cross-region[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "x-amz-content-sha256: UNSIGNED-PAYLOAD[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "X-Amz-Date: 20250917T174350Z[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
2025-09-17 18:43:50,574 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 >> "[\r][\n]"
2025-09-17 18:43:50,736 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "HTTP/1.1 204 No Content[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-request-id: 01f55be64a00019958c68a9f0509369410ff5343[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "HTTP/1.1 200 OK[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "server: AmazonS3[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "x-amz-request-id: 01dda0e93f00019958c68a8405090fbeac3fe28b[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "x-amz-id-2: nKMciQ1[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "content-type: application/xml[\r][\n]"
2025-09-17 18:43:50,739 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "content-length: 294[\r][\n]"
2025-09-17 18:43:50,739 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "x-amz-bucket-region: us-west-2[\r][\n]"
2025-09-17 18:43:50,739 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "date: Wed, 17 Sep 2025 17:43:50 GMT[\r][\n]"
2025-09-17 18:43:50,739 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "[\r][\n]"
2025-09-17 18:43:50,738 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "x-amz-id-2: Lf6ws7FbF7eZ6j1M[\r][\n]"
2025-09-17 18:43:50,741 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "date: Wed, 17 Sep 2025 17:43:50 GMT[\r][\n]"
2025-09-17 18:43:50,741 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-2 << "[\r][\n]"
2025-09-17 18:43:50,742 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 204, Request ID: 01f55be64a00019958c68a9f0509369410ff5343, Extended Request ID: Lf6ws7FbF7eZ6j1M
2025-09-17 18:43:50,742 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.S3AStoreImpl (DurationInfo.java:close(101)) - deleting test/: duration 0:00.170s
2025-09-17 18:43:50,743 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.S3AFileSystem (DurationInfo.java:close(101)) - Deleting 1 keys: duration 0:00.172s
2025-09-17 18:43:50,743 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - Remove S3 Dir Markers: duration 0:00.172s
2025-09-17 18:43:50,743 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t2] DEBUG impl.DeleteOperation (DurationInfo.java:close(101)) - Delete page of 2 keys: duration 0:00.337s
2025-09-17 18:43:50,743 [teardown] DEBUG impl.CallableSupplier (DurationInfo.java:close(101)) - Waiting for task completion: duration 0:00.337s
2025-09-17 18:43:50,743 [teardown] DEBUG impl.CallableSupplier (DurationInfo.java:<init>(80)) - Starting: Waiting for task completion
2025-09-17 18:43:50,749 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(73)) - http-outgoing-3 << "<?xml version="1.0" encoding="UTF-8"?>[\n]"
2025-09-17 18:43:50,749 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG http.wire (Wire.java:wire(87)) - http-outgoing-3 << "<ListMultipartUploadsResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Bucket>stevel--usw2-az1--x-s3</Bucket><KeyMarker/><NextKeyMarker/><Prefix>test/</Prefix><MaxUploads>1000</MaxUploads><IsTruncated>false</IsTruncated></ListMultipartUploadsResult>"
2025-09-17 18:43:50,751 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG awssdk.request (LoggerAdapter.java:debug(105)) - Received successful response: 200, Request ID: 01dda0e93f00019958c68a8405090fbeac3fe28b, Extended Request ID: nKMciQ1
2025-09-17 18:43:50,753 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG s3a.Invoker (DurationInfo.java:close(101)) - listMultipartUploads: duration 0:00.510s
2025-09-17 18:43:50,753 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG s3a.MultipartUtils (MultipartUtils.java:requestNextBatch(201)) - Listing found 0 upload(s)
2025-09-17 18:43:50,753 [s3a-transfer-stevel--usw2-az1--x-s3-bounded-pool2-t1] DEBUG s3a.MultipartUtils (MultipartUtils.java:requestNextBatch(203)) - New listing state: Upload iterator: prefix test/; list count 1; upload count 0; isTruncated=false
2025-09-17 18:43:50,753 [teardown] DEBUG impl.CallableSupplier (DurationInfo.java:close(101)) - Waiting for task completion: duration 0:00.010s
2025-09-17 18:43:50,754 [teardown] DEBUG impl.DeleteOperation (DurationInfo.java:close(101)) - deleting test/: duration 0:00.519s
2025-09-17 18:43:50,754 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:deleteDirectoryTree(297)) - Delete "s3a://stevel--usw2-az1--x-s3/test" completed; deleted 2 objects and aborted 0 uploads
2025-09-17 18:43:50,754 [teardown] DEBUG impl.DeleteOperation (DeleteOperation.java:execute(236)) - Deleted 2 objects
2025-09-17 18:43:50,756 [teardown] INFO  contract.AbstractFSContractTestBase (AbstractFSContractTestBase.java:describe(272)) - closing file system
2025-09-17 18:43:50,756 [teardown] DEBUG s3a.S3AFileSystem (S3AFileSystem.java:close(4349)) - Filesystem s3a://stevel--usw2-az1--x-s3 is closed
2025-09-17 18:43:50,756 [teardown] DEBUG s3a.S3AFileSystem (S3AUtils.java:closeAutocloseables(1566)) - Closing Service S3AStore in state S3AStore: STARTED
2025-09-17 18:43:50,757 [ForkJoinPool.commonPool-worker-9] DEBUG s3a.AWSCredentialProviderList (AWSCredentialProviderList.java:close(324)) - Closing AWSCredentialProviderList name=; refcount= 0; size=2: [TemporaryAWSCredentialsProvider, SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}] last provider: SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}
2025-09-17 18:43:50,759 [teardown] DEBUG s3a.S3AFileSystem (HadoopExecutors.java:shutdown(118)) - Gracefully shutting down executor service BlockingThreadPoolExecutorService{SemaphoredDelegatingExecutor{permitCount=192, available=192, waiting=0}, activeCount=0}. Waiting max 30 SECONDS
2025-09-17 18:43:50,759 [teardown] DEBUG s3a.S3AFileSystem (HadoopExecutors.java:shutdown(128)) - Succesfully shutdown executor service
2025-09-17 18:43:50,759 [teardown] DEBUG s3a.S3AFileSystem (HadoopExecutors.java:shutdown(118)) - Gracefully shutting down executor service java.util.concurrent.ThreadPoolExecutor@5a3a1bf9[Shutting down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]. Waiting max 30 SECONDS
2025-09-17 18:43:50,759 [teardown] DEBUG s3a.S3AFileSystem (HadoopExecutors.java:shutdown(128)) - Succesfully shutdown executor service
2025-09-17 18:43:50,759 [teardown] DEBUG delegation.S3ADelegationTokens (S3ADelegationTokens.java:serviceStop(227)) - Stopping delegation tokens
2025-09-17 18:43:50,760 [teardown] DEBUG auth.SignerManager (SignerManager.java:close(142)) - Unregistering fs from 0 initializers
2025-09-17 18:43:50,761 [teardown] DEBUG s3a.S3AFileSystem (S3AUtils.java:closeAutocloseables(1566)) - Closing AWSCredentialProviderList name=; refcount= 0; size=2: [TemporaryAWSCredentialsProvider, SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}] last provider: SimpleAWSCredentialsProvider{accessKey.empty=false, secretKey.empty=false}
2025-09-17 18:43:50,761 [teardown] DEBUG s3a.S3AInstrumentation (S3AInstrumentation.java:close(718)) - Unregistering metrics for S3AMetrics1-stevel--usw2-az1--x-s3
2025-09-17 18:43:50,761 [teardown] DEBUG s3a.S3AInstrumentation (S3AInstrumentation.java:close(734)) - Shutting down metrics publisher
2025-09-17 18:43:50,765 [teardown] DEBUG s3a.S3AFileSystem (IOStatisticsLogging.java:logIOStatisticsAtDebug(235)) - IOStatistics: counters=((stream_read_bytes=0) (stream_read_remote_stream_drain=0) (op_access.failures=0) (multipart_upload_abort_under_path_invoked=0) (op_create=1) (committer_stage_file_upload.failures=0) (object_list_request.failures=0) (op_create.failures=0) (committer_load_single_pending_file.failures=0) (op_xattr_get_named_map.failures=0) (committer_magic_marker_put=0) (object_multipart_list.failures=0) (store_client_creation=1) (stream_write_total_data=0) (stream_evict_blocks_from_cache=0) (action_http_head_request.failures=0) (object_put_request_completed=2) (committer_materialize_file=0) (action_executor_acquired=0) (stream_read_seek_backward_operations=0) (delegation_tokens_issued=0) (object_multipart_aborted=0) (http_response_5XX=0) (store_io_request=13) (committer_bytes_committed=0) (store_io_rate_limited_duration=0) (stream_read_vectored_combined_ranges=0) (store_exists_probe=0) (op_get_content_summary.failures=0) (op_exists=0) (stream_read_seek_operations=0) (multipart_upload_list.failures=0) (multipart_upload_completed=0) (op_list_files=0) (stream_write_queue_duration=0) (multipart_upload_part_put_bytes=0) (op_hsync=0) (files_deleted=1) (op_get_content_summary=0) (committer_commits_reverted=0) (files_delete_rejected=0) (fake_directories_deleted=1) (action_http_head_request=3) (object_delete_request=2) (object_delete_request.failures=0) (object_put_bytes=0) (committer_commits.failures=0) (committer_commit_job.failures=0) (store_io_retry=2) (stream_read_vectored_operations=0) (fake_directories_created=0) (op_rename.failures=0) (stream_read_seek_policy_changed=0) (filesystem_close.failures=0) (http_response_4XX=0) (directories_created=1) (stream_read_seek_bytes_discarded=0) (object_continue_list_request=0) (committer_jobs_completed=0) (committer_stage_file_upload=0) (stream_write_block_uploads_committed=0) (stream_read_remote_stream_drain.failures=0) (stream_read_closed=0) (op_createfile.failures=0) (committer_commit_job=0) (store_client_creation.failures=0) (http_response_500=0) (op_is_directory.failures=0) (object_multipart_list=1) (store_io_rate_limited_duration.failures=0) (conditional_create=0) (op_hflush=0) (store_io_throttled=0) (op_list_files.failures=0) (action_http_get_request=0) (committer_load_single_pending_file=0) (filesystem_initialization.failures=0) (files_copied_bytes=0) (op_get_delegation_token.failures=0) (files_copied=0) (object_put_request=2) (directories_deleted=0) (files_created=1) (http_response_400=0) (op_is_directory=0) (stream_write_exceptions_completing_upload=0) (op_xattr_list=0) (stream_read_vectored_read_bytes_discarded=0) (stream_write_queue_duration.failures=0) (op_get_file_status.failures=0) (op_openfile=0) (stream_read_version_mismatches=0) (object_bulk_delete_request=0) (stream_read_bytes_backwards_on_seek=0) (op_abort.failures=0) (audit_failure=0) (committer_magic_files_created=0) (stream_write_exceptions=0) (object_metadata_request=3) (action_file_opened.failures=0) (stream_read_opened=0) (stream_read_operations=0) (conditional_create_failed=0) (op_mkdirs=1) (op_mkdirs.failures=0) (committer_tasks_completed=0) (op_is_file.failures=0) (filesystem_initialization=1) (audit_access_check_failure=0) (stream_read_seek_forward_operations=0) (stream_read_close_operations=0) (committer_magic_marker_put.failures=0) (object_multipart_initiated.failures=0) (stream_file_cache_eviction=0) (op_abort=0) (stream_aborted=0) (action_executor_acquired.failures=0) (op_open=0) (op_createfile=0) (object_put_request.failures=0) (stream_read_exceptions=0) (committer_materialize_file.failures=0) (action_http_get_request.failures=0) (op_list_status=0) (op_get_file_checksum.failures=0) (committer_bytes_uploaded=0) (op_delete=1) (stream_write_block_uploads_aborted=0) (stream_file_cache_eviction.failures=0) (op_create_non_recursive=0) (audit_request_execution=11) (object_delete_objects=2) (stream_read_fully_operations=0) (op_copy_from_local_file=0) (op_xattr_get_map.failures=0) (ignored_errors=0) (stream_write_bytes=0) (http_response_503=0) (op_xattr_get_named=0) (stream_read_remote_stream_aborted=0) (op_xattr_get_map=0) (object_copy_requests=0) (op_list_located_status=0) (stream_read_seek_bytes_skipped=0) (stream_read_total_bytes=0) (object_bulk_delete_request.failures=0) (multipart_upload_part_put=0) (stream_read_remote_stream_aborted.failures=0) (committer_jobs_failed=0) (committer_commits_created=0) (multipart_upload_started=0) (analytics_stream_factory_closed=0) (committer_tasks_failed=0) (http_response_429=0) (committer_commits_completed=0) (op_is_file=0) (op_get_file_checksum=0) (action_file_opened=0) (stream_write_block_uploads=2) (delegation_tokens_issued.failures=0) (op_glob_status.failures=0) (object_multipart_initiated=0) (op_exists.failures=0) (op_xattr_list.failures=0) (op_delete.failures=0) (object_continue_list_request.failures=0) (op_xattr_get_named.failures=0) (stream_write_total_time=548) (object_list_request=3) (stream_read_unbuffered=0) (store_exists_probe.failures=0) (stream_read_operations_incomplete=0) (op_get_file_status=1) (stream_read_analytics_opened=0) (op_copy_from_local_file.failures=0) (op_list_status.failures=0) (committer_commits_aborted=0) (multipart_instantiated=0) (stream_read_bytes_discarded_in_close=0) (stream_read_vectored_incoming_ranges=0) (object_multipart_aborted.failures=0) (stream_leaks=0) (op_glob_status=0) (op_get_delegation_token=0) (multipart_upload_list=0) (stream_read_bytes_discarded_in_abort=0) (op_rename=0) (op_bulk-delete=0) (multipart_upload_aborted=0) (op_xattr_get_named_map=0) (audit_span_creation=6) (op_access=0) (filesystem_close=1));
gauges=((stream_write_block_uploads_active=0) (stream_write_block_uploads_data_pending=0) (object_put_request_active=0) (stream_read_active_prefetch_operations=0) (stream_read_active_memory_in_use=0) (client_side_encryption_enabled=0) (stream_write_block_uploads_pending=0) (stream_read_blocks_in_cache=0) (object_put_bytes_pending=0));
minimums=((filesystem_close.min=5) (op_get_file_checksum.failures.min=-1) (op_get_file_status.failures.min=-1) (op_xattr_list.failures.min=-1) (op_get_content_summary.min=-1) (object_multipart_list.failures.min=-1) (op_get_delegation_token.min=-1) (object_bulk_delete_request.failures.min=-1) (delegation_tokens_issued.failures.min=-1) (op_access.min=-1) (store_client_creation.failures.min=-1) (op_is_directory.min=-1) (op_xattr_get_named_map.failures.min=-1) (action_http_get_request.min=-1) (op_get_file_checksum.min=-1) (op_access.failures.min=-1) (op_list_files.failures.min=-1) (op_list_status.failures.min=-1) (object_list_request.failures.min=-1) (object_multipart_initiated.min=-1) (object_delete_request.min=162) (committer_materialize_file.failures.min=-1) (committer_materialize_file.min=-1) (op_rename.min=-1) (filesystem_initialization.failures.min=-1) (object_multipart_initiated.failures.min=-1) (store_exists_probe.failures.min=-1) (op_delete.min=519) (op_delete.failures.min=-1) (op_abort.min=-1) (action_file_opened.min=-1) (object_multipart_aborted.failures.min=-1) (store_io_rate_limited_duration.failures.min=-1) (object_put_request.min=547) (store_client_creation.min=295) (multipart_upload_list.failures.min=-1) (stream_read_remote_stream_aborted.min=-1) (op_xattr_get_map.min=-1) (object_list_request.min=158) (committer_magic_marker_put.failures.min=-1) (filesystem_close.failures.min=-1) (object_multipart_aborted.min=-1) (stream_write_queue_duration.min=-1) (object_multipart_list.min=510) (op_xattr_get_map.failures.min=-1) (filesystem_initialization.min=364) (op_createfile.min=-1) (op_xattr_get_named.failures.min=-1) (op_is_file.min=-1) (stream_read_remote_stream_aborted.failures.min=-1) (stream_read_remote_stream_drain.failures.min=-1) (committer_load_single_pending_file.min=-1) (object_bulk_delete_request.min=-1) (action_executor_acquired.min=0) (op_get_content_summary.failures.min=-1) (op_abort.failures.min=-1) (multipart_upload_list.min=-1) (action_executor_acquired.failures.min=-1) (action_http_get_request.failures.min=-1) (op_rename.failures.min=-1) (op_list_files.min=-1) (stream_file_cache_eviction.failures.min=-1) (op_glob_status.failures.min=-1) (object_delete_request.failures.min=-1) (stream_file_cache_eviction.min=-1) (committer_stage_file_upload.min=-1) (committer_commit_job.failures.min=-1) (op_is_file.failures.min=-1) (stream_write_queue_duration.failures.min=-1) (object_continue_list_request.min=-1) (op_exists.failures.min=-1) (op_mkdirs.min=1228) (op_mkdirs.failures.min=-1) (op_xattr_list.min=-1) (op_get_delegation_token.failures.min=-1) (action_http_head_request.failures.min=-1) (stream_read_remote_stream_drain.min=-1) (op_create.failures.min=-1) (committer_commit_job.min=-1) (op_copy_from_local_file.failures.min=-1) (op_list_status.min=-1) (op_is_directory.failures.min=-1) (op_exists.min=-1) (op_create.min=10) (op_xattr_get_named_map.min=-1) (op_get_file_status.min=557) (op_xattr_get_named.min=-1) (object_put_request.failures.min=-1) (committer_stage_file_upload.failures.min=-1) (op_createfile.failures.min=-1) (op_copy_from_local_file.min=-1) (op_glob_status.min=-1) (action_file_opened.failures.min=-1) (committer_magic_marker_put.min=-1) (committer_load_single_pending_file.failures.min=-1) (delegation_tokens_issued.min=-1) (store_exists_probe.min=-1) (action_http_head_request.min=162) (store_io_rate_limited_duration.min=0) (object_continue_list_request.failures.min=-1));
maximums=((store_io_rate_limited_duration.failures.max=-1) (op_is_file.failures.max=-1) (committer_commit_job.max=-1) (store_client_creation.max=295) (op_delete.max=519) (op_abort.max=-1) (op_xattr_list.failures.max=-1) (op_glob_status.max=-1) (committer_materialize_file.max=-1) (op_access.failures.max=-1) (filesystem_close.failures.max=-1) (object_bulk_delete_request.failures.max=-1) (object_bulk_delete_request.max=-1) (op_glob_status.failures.max=-1) (committer_load_single_pending_file.max=-1) (op_is_directory.max=-1) (object_list_request.failures.max=-1) (op_is_file.max=-1) (op_rename.max=-1) (stream_write_queue_duration.max=-1) (op_mkdirs.max=1228) (op_xattr_get_named.max=-1) (delegation_tokens_issued.max=-1) (action_http_get_request.failures.max=-1) (action_executor_acquired.max=0) (op_exists.max=-1) (op_list_files.max=-1) (committer_magic_marker_put.failures.max=-1) (store_exists_probe.failures.max=-1) (object_continue_list_request.max=-1) (object_multipart_aborted.max=-1) (op_get_file_status.max=557) (filesystem_initialization.failures.max=-1) (committer_stage_file_upload.failures.max=-1) (op_list_status.failures.max=-1) (store_client_creation.failures.max=-1) (op_get_file_status.failures.max=-1) (op_create.max=10) (multipart_upload_list.max=-1) (committer_commit_job.failures.max=-1) (object_delete_request.max=170) (op_createfile.failures.max=-1) (op_xattr_get_map.max=-1) (op_copy_from_local_file.max=-1) (stream_read_remote_stream_drain.failures.max=-1) (op_get_file_checksum.failures.max=-1) (stream_read_remote_stream_drain.max=-1) (action_executor_acquired.failures.max=-1) (op_xattr_get_named_map.failures.max=-1) (committer_load_single_pending_file.failures.max=-1) (op_copy_from_local_file.failures.max=-1) (stream_write_queue_duration.failures.max=-1) (op_xattr_list.max=-1) (object_multipart_initiated.max=-1) (object_multipart_list.failures.max=-1) (stream_read_remote_stream_aborted.failures.max=-1) (object_delete_request.failures.max=-1) (filesystem_close.max=5) (op_access.max=-1) (op_is_directory.failures.max=-1) (filesystem_initialization.max=364) (committer_magic_marker_put.max=-1) (action_file_opened.max=-1) (store_io_rate_limited_duration.max=0) (op_get_delegation_token.max=-1) (op_xattr_get_named.failures.max=-1) (op_xattr_get_map.failures.max=-1) (object_list_request.max=845) (op_exists.failures.max=-1) (action_http_head_request.failures.max=-1) (op_createfile.max=-1) (op_get_content_summary.max=-1) (op_abort.failures.max=-1) (op_xattr_get_named_map.max=-1) (op_list_status.max=-1) (action_http_get_request.max=-1) (op_rename.failures.max=-1) (stream_file_cache_eviction.max=-1) (object_multipart_list.max=510) (delegation_tokens_issued.failures.max=-1) (op_get_delegation_token.failures.max=-1) (store_exists_probe.max=-1) (committer_stage_file_upload.max=-1) (op_mkdirs.failures.max=-1) (stream_file_cache_eviction.failures.max=-1) (op_get_file_checksum.max=-1) (object_multipart_initiated.failures.max=-1) (object_put_request.max=547) (op_delete.failures.max=-1) (object_put_request.failures.max=-1) (multipart_upload_list.failures.max=-1) (op_list_files.failures.max=-1) (committer_materialize_file.failures.max=-1) (op_get_content_summary.failures.max=-1) (action_http_head_request.max=556) (object_continue_list_request.failures.max=-1) (object_multipart_aborted.failures.max=-1) (action_file_opened.failures.max=-1) (stream_read_remote_stream_aborted.max=-1) (op_create.failures.max=-1));
means=((object_multipart_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_map.mean=(samples=0, sum=0, mean=0.0000)) (op_create.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_stage_file_upload.mean=(samples=0, sum=0, mean=0.0000)) (op_list_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_continue_list_request.mean=(samples=0, sum=0, mean=0.0000)) (store_io_rate_limited_duration.mean=(samples=2, sum=0, mean=0.0000)) (op_xattr_get_named_map.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_close.mean=(samples=1, sum=5, mean=5.0000)) (action_http_get_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_materialize_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_delete_request.mean=(samples=2, sum=332, mean=166.0000)) (multipart_upload_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_aborted.mean=(samples=0, sum=0, mean=0.0000)) (op_mkdirs.mean=(samples=1, sum=1228, mean=1228.0000)) (op_access.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_file_cache_eviction.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_drain.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_aborted.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_map.failures.mean=(samples=0, sum=0, mean=0.0000)) (delegation_tokens_issued.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_drain.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_delegation_token.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_list.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_copy_from_local_file.mean=(samples=0, sum=0, mean=0.0000)) (multipart_upload_list.mean=(samples=0, sum=0, mean=0.0000)) (committer_commit_job.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_write_queue_duration.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_exists_probe.failures.mean=(samples=0, sum=0, mean=0.0000)) (stream_write_queue_duration.mean=(samples=0, sum=0, mean=0.0000)) (delegation_tokens_issued.failures.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_initialization.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_glob_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_http_get_request.mean=(samples=0, sum=0, mean=0.0000)) (op_abort.mean=(samples=0, sum=0, mean=0.0000)) (committer_commit_job.mean=(samples=0, sum=0, mean=0.0000)) (stream_read_remote_stream_aborted.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_create.mean=(samples=1, sum=10, mean=10.0000)) (op_xattr_get_named.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_close.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_list_files.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.mean=(samples=2, sum=730, mean=365.0000)) (op_copy_from_local_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_delete_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_list_files.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_initiated.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_mkdirs.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_delegation_token.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_file.mean=(samples=0, sum=0, mean=0.0000)) (action_file_opened.mean=(samples=0, sum=0, mean=0.0000)) (op_get_content_summary.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_get_named_map.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_file_opened.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_load_single_pending_file.mean=(samples=0, sum=0, mean=0.0000)) (committer_magic_marker_put.failures.mean=(samples=0, sum=0, mean=0.0000)) (committer_materialize_file.mean=(samples=0, sum=0, mean=0.0000)) (op_rename.mean=(samples=0, sum=0, mean=0.0000)) (op_exists.mean=(samples=0, sum=0, mean=0.0000)) (object_list_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_status.mean=(samples=1, sum=557, mean=557.0000)) (op_access.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_client_creation.failures.mean=(samples=0, sum=0, mean=0.0000)) (store_client_creation.mean=(samples=1, sum=295, mean=295.0000)) (op_list_status.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_status.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_list_request.mean=(samples=3, sum=1194, mean=398.0000)) (committer_load_single_pending_file.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_directory.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_is_directory.mean=(samples=0, sum=0, mean=0.0000)) (store_io_rate_limited_duration.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_http_head_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_delete.mean=(samples=1, sum=519, mean=519.0000)) (object_multipart_initiated.mean=(samples=0, sum=0, mean=0.0000)) (store_exists_probe.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_continue_list_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_createfile.mean=(samples=0, sum=0, mean=0.0000)) (action_http_head_request.mean=(samples=3, sum=888, mean=296.0000)) (committer_magic_marker_put.mean=(samples=0, sum=0, mean=0.0000)) (object_multipart_list.mean=(samples=1, sum=510, mean=510.0000)) (op_delete.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_bulk_delete_request.mean=(samples=0, sum=0, mean=0.0000)) (stream_file_cache_eviction.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_createfile.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_put_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_exists.failures.mean=(samples=0, sum=0, mean=0.0000)) (object_bulk_delete_request.failures.mean=(samples=0, sum=0, mean=0.0000)) (action_executor_acquired.mean=(samples=1, sum=0, mean=0.0000)) (op_rename.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_checksum.mean=(samples=0, sum=0, mean=0.0000)) (op_get_content_summary.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_get_file_checksum.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_xattr_list.mean=(samples=0, sum=0, mean=0.0000)) (filesystem_initialization.mean=(samples=1, sum=364, mean=364.0000)) (committer_stage_file_upload.failures.mean=(samples=0, sum=0, mean=0.0000)) (op_glob_status.mean=(samples=0, sum=0, mean=0.0000)));

2025-09-17 18:43:50,772 [teardown] INFO  s3a.AbstractS3ATestBase (AbstractS3ATestBase.java:dumpFileSystemIOStatistics(136)) - Aggregate FileSystem Statistics counters=((action_http_head_request=3)
(audit_request_execution=11)
(audit_span_creation=6)
(directories_created=1)
(fake_directories_deleted=1)
(files_created=1)
(files_deleted=1)
(filesystem_initialization=1)
(object_delete_objects=2)
(object_delete_request=2)
(object_list_request=3)
(object_metadata_request=3)
(object_multipart_list=1)
(object_put_request=2)
(object_put_request_completed=2)
(op_create=1)
(op_delete=1)
(op_get_file_status=1)
(op_mkdirs=1)
(store_client_creation=1)
(store_io_request=13)
(store_io_retry=2)
(stream_write_block_uploads=2)
(stream_write_total_time=548));

gauges=();

minimums=((action_executor_acquired.min=0)
(action_http_head_request.min=162)
(filesystem_initialization.min=364)
(object_delete_request.min=162)
(object_list_request.min=158)
(object_multipart_list.min=510)
(object_put_request.min=547)
(op_create.min=10)
(op_delete.min=519)
(op_get_file_status.min=557)
(op_mkdirs.min=1228)
(store_client_creation.min=295)
(store_io_rate_limited_duration.min=0));

maximums=((action_executor_acquired.max=0)
(action_http_head_request.max=556)
(filesystem_initialization.max=364)
(object_delete_request.max=170)
(object_list_request.max=845)
(object_multipart_list.max=510)
(object_put_request.max=547)
(op_create.max=10)
(op_delete.max=519)
(op_get_file_status.max=557)
(op_mkdirs.max=1228)
(store_client_creation.max=295)
(store_io_rate_limited_duration.max=0));

means=((action_executor_acquired.mean=(samples=1, sum=0, mean=0.0000))
(action_http_head_request.mean=(samples=3, sum=888, mean=296.0000))
(filesystem_initialization.mean=(samples=1, sum=364, mean=364.0000))
(object_delete_request.mean=(samples=2, sum=332, mean=166.0000))
(object_list_request.mean=(samples=3, sum=1194, mean=398.0000))
(object_multipart_list.mean=(samples=1, sum=510, mean=510.0000))
(object_put_request.mean=(samples=2, sum=730, mean=365.0000))
(op_create.mean=(samples=1, sum=10, mean=10.0000))
(op_delete.mean=(samples=1, sum=519, mean=519.0000))
(op_get_file_status.mean=(samples=1, sum=557, mean=557.0000))
(op_mkdirs.mean=(samples=1, sum=1228, mean=1228.0000))
(store_client_creation.mean=(samples=1, sum=295, mean=295.0000))
(store_io_rate_limited_duration.mean=(samples=2, sum=0, mean=0.0000)));