2025-12-12 13:28:16,260 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 13:28:16,261 - INFO - ya.test - pytest_runtest_setup: test_date_time_simple_format_insert[v2-common/simple_format/test.parquet-parquet]
2025-12-12 13:28:16,262 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 13:28:16,263 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-12 13:28:16,341 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_format_setting.py::TestS3, test_name: test_date_time_simple_format_insert[v2-common/simple_format/test.parquet-parquet])
2025-12-12 13:28:16,344 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:28:16,346 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:28:16,347 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:28:16,347 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:28:16,350 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:28:16,355 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:28:16,359 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:28:16,360 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-12-12 13:28:16,362 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-12-12 13:28:16,363 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-12-12 13:28:16,364 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7f3737982090>
2025-12-12 13:28:16,364 - DEBUG - boto3.resources.action - __call__: Calling s3:create_bucket with {'Bucket': 'fbucket', 'ACL': 'public-read'}
2025-12-12 13:28:16,365 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:16,365 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:16,365 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,366 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:16,367 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:16,367 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,367 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableAccessPoints': True, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:16,369 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:16,369 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:16,370 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:16,371 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:16,371 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:16,372 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:16,373 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=CreateBucket) with params: {'url_path': '', 'query_string': {}, 'method': 'PUT', 'headers': {'x-amz-acl': 'public-read', 'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource'}, 'body': b'', 'auth_path': '/fbucket/', 'url': 'http://localhost:24309/fbucket', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f371ab62270>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'ACL': 'public-read'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:16,373 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371ab61780>>
2025-12-12 13:28:16,375 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.CreateBucket: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b86f350>>
2025-12-12 13:28:16,377 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.CreateBucket: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:16,377 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.CreateBucket: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:16,379 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:16,379 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket

host:localhost:24309
x-amz-acl:public-read
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132816Z

host;x-amz-acl;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:28:16,380 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132816Z
20251212/yandex/s3/aws4_request
8c801bb263b843938e89afd1665eedc399c562a12f2b13839635fcfa6006b2f0
2025-12-12 13:28:16,381 - DEBUG - botocore.auth - add_auth: Signature:
a1a821ff922a1724dc78dc9073d72743b6a57a77cbc4fd5bd77276584484e3a6
2025-12-12 13:28:16,382 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:16,383 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:24309/fbucket, headers={'x-amz-acl': b'public-read', 'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'X-Amz-Date': b'20251212T132816Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=host;x-amz-acl;x-amz-content-sha256;x-amz-date, Signature=a1a821ff922a1724dc78dc9073d72743b6a57a77cbc4fd5bd77276584484e3a6', 'amz-sdk-invocation-id': b'3a6864ad-f54f-4b4f-91eb-c413e0417d78', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2025-12-12 13:28:16,397 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'x-amzn-requestid': 'BZezO8ZbkdyKGuRQUUbB2LtW6QDSjfITJQrNYZO9MWP1OQ3koRM0', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '161', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:16,398 - DEBUG - botocore.parsers - parse: Response body:
b'<CreateBucketResponse xmlns="http://s3.amazonaws.com/doc/2006-03-01"><CreateBucketResponse><Bucket>fbucket</Bucket></CreateBucketResponse></CreateBucketResponse>'
2025-12-12 13:28:16,399 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b3f3170>
2025-12-12 13:28:16,400 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:16,400 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,401 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'BZezO8ZbkdyKGuRQUUbB2LtW6QDSjfITJQrNYZO9MWP1OQ3koRM0', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'x-amzn-requestid': 'BZezO8ZbkdyKGuRQUUbB2LtW6QDSjfITJQrNYZO9MWP1OQ3koRM0', 'content-type': 'text/html; charset=utf-8', 'content-length': '161', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}}
2025-12-12 13:28:16,402 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-12-12 13:28:16,403 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function set_list_objects_encoding_type_url at 0x7f3738f587d0>
2025-12-12 13:28:16,404 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:16,405 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:16,406 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,406 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:16,407 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:16,408 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,408 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:16,410 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:16,411 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:16,411 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:16,412 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:16,412 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:16,413 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:16,414 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=ListObjects) with params: {'url_path': '', 'query_string': {'encoding-type': 'url'}, 'method': 'GET', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource'}, 'body': b'', 'auth_path': '/fbucket/', 'url': 'http://localhost:24309/fbucket?encoding-type=url', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f371ab62270>, 'has_streaming_input': False, 'auth_type': 'v4', 'encoding_type_auto_set': True, 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'EncodingType': 'url'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:16,415 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371ab61780>>
2025-12-12 13:28:16,417 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b86f350>>
2025-12-12 13:28:16,417 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:16,419 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:16,420 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:16,420 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132816Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:28:16,420 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132816Z
20251212/yandex/s3/aws4_request
a8eed8aa06e45df1346bbfff87cdd2d12ec8a6070733119550498de521377f32
2025-12-12 13:28:16,420 - DEBUG - botocore.auth - add_auth: Signature:
27a8473766a52ed3c305b18dec454b1818adddd11b685470c15a5daf15987d18
2025-12-12 13:28:16,421 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:16,421 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=GET, url=http://localhost:24309/fbucket?encoding-type=url, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'X-Amz-Date': b'20251212T132816Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=27a8473766a52ed3c305b18dec454b1818adddd11b685470c15a5daf15987d18', 'amz-sdk-invocation-id': b'f57f918d-71be-47c6-86d2-69d6620caafe', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:28:16,428 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'x-amzn-requestid': 'wpffM6kJbZtoM6F3eu5sGlE6IvvKVwQYPsFTMsM7gFTuFGoClYyx', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '985', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:16,428 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>fbucket</Name><MaxKeys>1000</MaxKeys><EncodingType>url</EncodingType><IsTruncated>false</IsTruncated><Contents><Key>common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json</Key><LastModified>2025-12-12T13:28:15.000Z</LastModified><ETag>&#34;12d351f710dc1c1177b3b8e30a7ee5ab&#34;</ETag><Size>122</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>common/simple_format/test.json</Key><LastModified>2025-12-12T13:28:14.000Z</LastModified><ETag>&#34;5a33a9ccacce9e4a7fe17f94b75ee072&#34;</ETag><Size>185</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-12-12 13:28:16,432 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b3f3170>
2025-12-12 13:28:16,432 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:16,432 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,433 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7f3738f58890>
2025-12-12 13:28:16,433 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-12-12 13:28:16,434 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-12-12 13:28:16,435 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7f3737982210>
2025-12-12 13:28:16,437 - DEBUG - boto3.resources.action - __call__: Calling s3:delete_objects with {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json'}, {'Key': 'common/simple_format/test.json'}]}}
2025-12-12 13:28:16,438 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:16,441 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:16,442 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,443 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:16,443 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:16,444 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,444 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:16,445 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:16,445 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:16,446 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:16,448 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function escape_xml_payload at 0x7f3738f328d0>
2025-12-12 13:28:16,452 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:16,452 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:16,453 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:16,453 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=DeleteObjects) with params: {'url_path': '?delete', 'query_string': {}, 'method': 'POST', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'Content-MD5': 'OPJ5gPZXEa36hN/pXn1fsw=='}, 'body': b'<Delete xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Object><Key>common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json</Key></Object><Object><Key>common/simple_format/test.json</Key></Object></Delete>', 'auth_path': '/fbucket/', 'url': 'http://localhost:24309/fbucket?delete', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f371ab62270>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json'}, {'Key': 'common/simple_format/test.json'}]}}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'checksum': {'request_algorithm': 'conditional-md5'}}}
2025-12-12 13:28:16,455 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371ab61780>>
2025-12-12 13:28:16,455 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.DeleteObjects: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b86f350>>
2025-12-12 13:28:16,455 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.DeleteObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:16,456 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.DeleteObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:16,456 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:16,458 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
POST
/fbucket
delete=
content-md5:OPJ5gPZXEa36hN/pXn1fsw==
host:localhost:24309
x-amz-content-sha256:32d9aaca9784b5577e0263b050de505d09e0d9c9c4007f9de2825b1c044a8445
x-amz-date:20251212T132816Z

content-md5;host;x-amz-content-sha256;x-amz-date
32d9aaca9784b5577e0263b050de505d09e0d9c9c4007f9de2825b1c044a8445
2025-12-12 13:28:16,458 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132816Z
20251212/yandex/s3/aws4_request
d7c8d29fc12080d9b86dafdb3d918c9143bfcd233be4da4e69e4611622fa61a8
2025-12-12 13:28:16,458 - DEBUG - botocore.auth - add_auth: Signature:
19b3d1b46d7e4ea831804f079e3b2d650e81ef8b3312f35d38fb675cff70cf17
2025-12-12 13:28:16,460 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:16,460 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=POST, url=http://localhost:24309/fbucket?delete, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'Content-MD5': b'OPJ5gPZXEa36hN/pXn1fsw==', 'X-Amz-Date': b'20251212T132816Z', 'X-Amz-Content-SHA256': b'32d9aaca9784b5577e0263b050de505d09e0d9c9c4007f9de2825b1c044a8445', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=19b3d1b46d7e4ea831804f079e3b2d650e81ef8b3312f35d38fb675cff70cf17', 'amz-sdk-invocation-id': b'f0bed62a-827c-4d1b-9bc0-cb32680c8d2e', 'amz-sdk-request': b'attempt=1', 'Content-Length': '246'}>
2025-12-12 13:28:16,468 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'x-amzn-requestid': 'tz88hYaVSwWRPJF13ZDmZYgvoNt2MIw2y3OuVjktLCEwXvSXABkC', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '299', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:16,468 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><DeleteResult xmlns="http://s3.amazonaws.com/doc/2006-03-01"><Deleted><Key>common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json</Key></Deleted><Deleted><Key>common/simple_format/test.json</Key></Deleted></DeleteResult>'
2025-12-12 13:28:16,471 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b3f3170>
2025-12-12 13:28:16,471 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:16,472 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b227080>>
2025-12-12 13:28:16,473 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'tz88hYaVSwWRPJF13ZDmZYgvoNt2MIw2y3OuVjktLCEwXvSXABkC', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'x-amzn-requestid': 'tz88hYaVSwWRPJF13ZDmZYgvoNt2MIw2y3OuVjktLCEwXvSXABkC', 'content-type': 'text/html; charset=utf-8', 'content-length': '299', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}, 'Deleted': [{'Key': 'common/simple_format/json_each_row/ptjudq7r22q0uhfu0e5e_0_mzVMT1w9y02lr53j1KDJZ8AkPowKEI93.json'}, {'Key': 'common/simple_format/test.json'}]}
2025-12-12 13:28:16,475 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:28:16,482 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:28:16,482 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:28:16,482 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:28:16,485 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:28:16,489 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:28:16,490 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:28:16,493 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:28:16,494 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3720b330d0>}) about to wait for the following futures []
2025-12-12 13:28:16,495 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3720b330d0>}) done waiting for dependent futures
2025-12-12 13:28:16,496 - DEBUG - s3transfer.tasks - _execute_main: Executing task UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3720b330d0>}) with kwargs {'client': <botocore.client.S3 object at 0x7f3738280b50>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7f371abf77b0>, 'osutil': <s3transfer.utils.OSUtils object at 0x7f3720b32310>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7f3720b31000>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3720b330d0>}
2025-12-12 13:28:16,496 - DEBUG - s3transfer.futures - submit: Submitting task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.parquet', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7f3720b31000> for transfer request: 0.
2025-12-12 13:28:16,498 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:28:16,499 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.parquet', 'extra_args': {}}) about to wait for the following futures []
2025-12-12 13:28:16,499 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:28:16,500 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.parquet', 'extra_args': {}}) done waiting for dependent futures
2025-12-12 13:28:16,502 - DEBUG - s3transfer.tasks - _execute_main: Executing task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.parquet', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7f3738280b50>, 'fileobj': <s3transfer.utils.ReadFileChunk object at 0x7f373802ea40>, 'bucket': 'fbucket', 'key': 'common/simple_format/test.parquet', 'extra_args': {}}
2025-12-12 13:28:16,503 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_ascii_metadata at 0x7f3738f33f50>
2025-12-12 13:28:16,503 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:28:16,504 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function convert_body_to_file_like_object at 0x7f3738f58c50>
2025-12-12 13:28:16,504 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:16,504 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:16,505 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3738119140>>
2025-12-12 13:28:16,505 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:16,506 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:16,506 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3738119140>>
2025-12-12 13:28:16,507 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:16,509 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:16,510 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:16,512 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:16,513 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function conditionally_calculate_md5 at 0x7f373914fe90>
2025-12-12 13:28:16,515 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:16,518 - DEBUG - botocore.handlers - add_expect_header: Adding expect 100 continue header to request.
2025-12-12 13:28:16,519 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:16,520 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:16,520 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=PutObject) with params: {'url_path': '/common/simple_format/test.parquet', 'query_string': {}, 'method': 'PUT', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80', 'Content-MD5': 'AhVx/h6601cVyA4ibWXxEw==', 'Expect': '100-continue'}, 'body': <s3transfer.utils.ReadFileChunk object at 0x7f373802ea40>, 'auth_path': '/fbucket/common/simple_format/test.parquet', 'url': 'http://localhost:24309/fbucket/common/simple_format/test.parquet', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f373811aa40>, 'has_streaming_input': True, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/test.parquet', 'Body': <s3transfer.utils.ReadFileChunk object at 0x7f373802ea40>}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:16,522 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:28:16,523 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f3738118d80>>
2025-12-12 13:28:16,524 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.PutObject: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371abf73f0>>
2025-12-12 13:28:16,525 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.PutObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:16,529 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.PutObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:16,532 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:16,532 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket/common/simple_format/test.parquet

content-md5:AhVx/h6601cVyA4ibWXxEw==
host:localhost:24309
x-amz-content-sha256:f85b5eb621e683410f2b258157151744e1e7262c1ee0c87be3527eff1368a5c0
x-amz-date:20251212T132816Z

content-md5;host;x-amz-content-sha256;x-amz-date
f85b5eb621e683410f2b258157151744e1e7262c1ee0c87be3527eff1368a5c0
2025-12-12 13:28:16,532 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132816Z
20251212/yandex/s3/aws4_request
56bb9a7135c3400ca701bd775785d39f8c1be483a0f79b7f2f09f1d69942675e
2025-12-12 13:28:16,534 - DEBUG - botocore.auth - add_auth: Signature:
689b1279d35ef5e110422bc1c38d500821f15745f1f8b21bc12373167c558569
2025-12-12 13:28:16,546 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:28:16,563 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:16,564 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:24309/fbucket/common/simple_format/test.parquet, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80', 'Content-MD5': b'AhVx/h6601cVyA4ibWXxEw==', 'Expect': b'100-continue', 'X-Amz-Date': b'20251212T132816Z', 'X-Amz-Content-SHA256': b'f85b5eb621e683410f2b258157151744e1e7262c1ee0c87be3527eff1368a5c0', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=689b1279d35ef5e110422bc1c38d500821f15745f1f8b21bc12373167c558569', 'amz-sdk-invocation-id': b'933d055c-e703-40d9-bde2-87a3648aab0b', 'amz-sdk-request': b'attempt=1', 'Content-Length': '1089'}>
2025-12-12 13:28:16,567 - DEBUG - botocore.awsrequest - _send_output: Waiting for 100 Continue response.
2025-12-12 13:28:16,569 - DEBUG - botocore.awsrequest - _handle_expect_response: 100 Continue response seen, now sending request body.
2025-12-12 13:28:16,573 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:16 GMT', 'ETag': '"021571fe1ebad35715c80e226d65f113"', 'last-modified': 'Fri, 12 Dec 2025 13:28:16 GMT', 'Content-Length': '0', 'x-amzn-requestid': 'Itvi5C2rReXuHaPq1wDRxlI6kr1ripT6iVrOjPbWJJBXpP6Jkxqt', 'Content-Type': 'text/html; charset=utf-8', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:16,573 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-12-12 13:28:16,575 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f3720b33a30>
2025-12-12 13:28:16,575 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:16,576 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3738119140>>
2025-12-12 13:28:16,577 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:28:16,579 - DEBUG - root - wait_bootstrap: Wait for node 1 to bootstrap
2025-12-12 13:28:16,604 - DEBUG - root - wait_bootstrap: Node 1 has been bootstrapped
2025-12-12 13:28:16,755 - DEBUG - root - create_query_impl: Request: content {
  type: ANALYTICS
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO bindings.`h8810004111901439312_test_date_time_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h8810004111901439312_test_date_time_simple_format_insertmy_binding`\n            "
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "6ffcf2f7-7ac4-4042-834a-b521a60d05dd"

2025-12-12 13:28:16,778 - DEBUG - root - create_query_impl: Result: query_id: "ptqudq7r212qmcem2h8d"

2025-12-12 13:28:16,791 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7r212qmcem2h8d"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765546096
        nanos: 760105000
      }
      modified_at {
        seconds: 1765546096
        nanos: 760105000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudq7r212qljfs66h6-ptqudq7r212qmcem2h8d"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765546096
      nanos: 760105000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h8810004111901439312_test_date_time_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h8810004111901439312_test_date_time_simple_format_insertmy_binding`\n            "
    syntax: YQL_V1
  }
}

2025-12-12 13:28:17,302 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7r212qmcem2h8d"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765546096
        nanos: 760105000
      }
      modified_at {
        seconds: 1765546096
        nanos: 760105000
      }
      revision: 1
    }
    started_at {
      seconds: 1765546096
      nanos: 821000000
    }
    finished_at {
      seconds: 1765546096
      nanos: 970000000
    }
    execute_mode: RUN
    status: COMPLETED
    last_job_query_revision: 1
    last_job_id: "ptjudq7r212qljfs66h6-ptqudq7r212qmcem2h8d"
    result_expire_at {
      seconds: 1765632496
      nanos: 803732000
    }
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765546096
      nanos: 760105000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h8810004111901439312_test_date_time_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h8810004111901439312_test_date_time_simple_format_insertmy_binding`\n            "
    syntax: YQL_V1
  }
  plan {
    json: "{\"Plan\":{\"Plans\":[{\"PlanNodeId\":5,\"Plans\":[{\"PlanNodeId\":4,\"Plans\":[{\"PlanNodeId\":3,\"Plans\":[{\"PlanNodeId\":2,\"Plans\":[{\"PlanNodeId\":1,\"Operators\":[{\"E-Size\":\"2420\",\"Format\":\"parquet\",\"Name\":\"h8810004111901439312_test_date_time_simple_format_insertmy_binding\",\"Inputs\":[],\"Path\":\"common/simple_format/test.parquet \",\"E-Rows\":\"55\",\"ExternalDataSource\":\"h8810004111901439312_test_date_time_simple_format_insertfruitbucket\",\"ReadColumns\":[\"Fruit\",\"Price\",\"Time\",\"Weight\"],\"SourceType\":\"s3\",\"E-Cost\":\"1089\"}],\"Node Type\":\"Source\"}],\"Node Type\":\"Stage\"}],\"Node Type\":\"Map\",\"PlanNodeType\":\"Connection\"}],\"Node Type\":\"Stage\"}],\"Operators\":[{\"Inputs\":[],\"ExternalDataSource\":\"h8810004111901439312_test_date_time_simple_format_insertfruitbucket\",\"Extension\":\".parquet\",\"Name\":\"Write h8810004111901439312_test_date_time_simple_format_insertfruitbucket\",\"SinkType\":\"s3\"}],\"Node Type\":\"Sink\"}],\"Node Type\":\"Query\",\"PlanNodeType\":\"Query\"},\"meta\":{\"version\":\"0.2\",\"type\":\"query\"}}"
  }
  statistics {
    json: "{\"Sink\":{\"Tasks\":{\"sum\":2,\"count\":2,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"805us\",\"count\":2,\"avg\":\"402us\",\"max\":\"628us\",\"min\":\"177us\"},\"IngressBytes\":{\"sum\":1638,\"count\":1,\"avg\":1638,\"max\":1638,\"min\":1638},\"IngressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"InputBytes\":{\"sum\":33,\"count\":1,\"avg\":33,\"max\":33,\"min\":33},\"InputRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"OutputBytes\":{\"sum\":33,\"count\":1,\"avg\":33,\"max\":33,\"min\":33},\"OutputRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"EgressBytes\":{\"sum\":1125,\"count\":1,\"avg\":1125,\"max\":1125,\"min\":1125},\"EgressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"MaxMemoryUsage\":{\"sum\":212860928,\"count\":2,\"avg\":106430464,\"max\":210763776,\"min\":2097152}}}"
  }
  ast {
    data: "(\n(let $1 \'\"/local/h8810004111901439312_test_date_time_simple_format_insertfruitbucket\")\n(let $2 \'\"/local/h8810004111901439312_test_date_time_simple_format_insertmy_binding\")\n(let $3 (DataSource \'\"s3\" $1 $2))\n(let $4 \'\"Paths {\\n  Name: \\\"common\\\"\\n  Children {\\n    Name: \\\"simple_format\\\"\\n    Children {\\n      Name: \\\"test.parquet\\\"\\n      Size: 1089\\n      Read: true\\n    }\\n    IsDirectory: true\\n  }\\n  IsDirectory: true\\n}\\n\")\n(let $5 (Bool \'\"true\"))\n(let $6 \'\"cluster:default_/local/h8810004111901439312_test_date_time_simple_format_insertfruitbucket\")\n(let $7 (SecureParam $6))\n(let $8 (DataType \'Int32))\n(let $9 (StructType \'(\'\"Fruit\" (DataType \'String)) \'(\'\"Price\" $8) \'(\'\"Time\" (DataType \'Datetime)) \'(\'\"Weight\" $8)))\n(let $10 (S3ParseSettings world \'(\'((String $4) $5 (AsStruct))) $7 \'\"\" \'\"common/simple_format/test.parquet \" \'\"parquet\" $9 (lambda \'($16) $5) \'(\'(\'\"data.datetime.format\" \'\"%Y-%m-%d\"))))\n(let $11 \'(\'(\'\"_logical_id\" \'606) \'(\'\"_id\" \'\"e84d54c7-85ad1ada-7ed425e5-a5047b51\") \'(\'\"_wide_channels\" $9)))\n(let $12 (DqPhyStage \'((DqSource $3 $10)) (lambda \'($17) (block \'(\n  (let $18 (lambda \'($19 $20 $21 $22) $19 $20 (Unwrap (+ $21 (Interval \'\"86400000000\"))) $22))\n  (return (FromFlow (WideMap (ToFlow (WideFromBlocks (FromFlow (DqSourceWideBlockWrap $17 $3 $9 \'(\'(\'format \'\"parquet\")))))) $18)))\n))) $11))\n(let $13 (DqCnMap (TDqOutput $12 \'\"0\")))\n(let $14 (S3SinkSettings \'\"common/simple_format/parquet/\" \'(\'(\'\"multipart\" \'\"true\") \'(\'\"block_output\" \'\"true\")) $7 \'\".parquet\" $9))\n(let $15 (DqPhyStage \'($13) (lambda \'($23) (WideToBlocks $23)) \'(\'(\'\"_logical_id\" \'714) \'(\'\"_id\" \'\"dc0895f6-78ba3b5b-282ded2e-64b875ea\")) \'((DqSink \'\"0\" (DataSink \'\"s3\" $1) $14))))\n(return (KqpPhysicalQuery \'((KqpPhysicalTx \'($12 $15) \'() \'() \'(\'(\'\"type\" \'\"generic\") \'(\'\"with_effects\")))) \'() \'(\'(\'\"type\" \'\"script\"))))\n)\n"
  }
  timeline {
    svg: "<svg width=\'1280\' height=\'146\' xmlns=\'http://www.w3.org/2000/svg\'>\n<clipPath id=\'clipTextPath\'><rect x=\'0\' y=\'0\' width=\'298\' height=\'146\'/></clipPath>\n\n<defs>\n\n<g id=\'icon_memory\'>\n  <path fill-rule=\'evenodd\' clip-rule=\'evenodd\' d=\'M5 3C3.89543 3 3 3.89543 3 5H1V7H3V9H1V11H3V13H1V15H3V17H1V19H3C3 20.1046 3.89543 21 5 21H9C10.1046 21 11 20.1046 11 19H13C13 20.1046 13.8954 21 15 21H19C20.1046 21 21 20.1046 21 19H23V17H21V15H23V13H21V11H23V9H21V7H23V5H21C21 3.89543 20.1046 3 19 3H15C13.8954 3 13 3.89543 13 5H11C11 3.89543 10.1046 3 9 3H5ZM11 7V9H13V7H11ZM11 11V13H13V11H11ZM11 15V17H13V15H11ZM5 5H9V19H5V5ZM15 5H19V19H15V5Z\' />\n</g>\n\n<g id=\'icon_cpu\'>\n  <path d=\'M13.9802 7.75H10.0102C8.76023 7.75 7.74023 8.76 7.74023 10.02V13.99C7.74023 15.24 8.75023 16.26 10.0102 16.26H13.9802C15.2302 16.26 16.2502 15.25 16.2502 13.99V10.02C16.2502 8.76 15.2402 7.75 13.9802 7.75ZM13.5002 12.98L12.6102 14.53C12.4802 14.76 12.2402 14.88 12.0002 14.88C11.8802 14.88 11.7502 14.85 11.6502 14.79C11.3102 14.6 11.1902 14.17 11.3902 13.83L12.0302 12.72H11.4702C11.0202 12.72 10.6502 12.52 10.4502 12.18C10.2502 11.84 10.2702 11.42 10.5002 11.03L11.3902 9.48C11.5902 9.14 12.0202 9.03 12.3502 9.22C12.6902 9.41 12.8102 9.84 12.6102 10.18L11.9702 11.29H12.5302C12.9802 11.29 13.3502 11.49 13.5502 11.83C13.7502 12.17 13.7302 12.59 13.5002 12.98Z\' />\n  <path d=\'M21.25 12.75C21.67 12.75 22 12.41 22 12C22 11.58 21.67 11.25 21.25 11.25H20V9.05H21.25C21.67 9.05 22 8.72 22 8.3C22 7.89 21.67 7.55 21.25 7.55H19.77C19.29 5.96 18.04 4.71 16.45 4.23V2.75C16.45 2.34 16.11 2 15.7 2C15.29 2 14.95 2.34 14.95 2.75V4H12.75V2.75C12.75 2.34 12.41 2 12 2C11.59 2 11.25 2.34 11.25 2.75V4H9.06V2.75C9.06 2.34 8.72 2 8.31 2C7.89 2 7.56 2.34 7.56 2.75V4.23C5.96 4.71 4.71 5.96 4.23 7.55H2.75C2.34 7.55 2 7.89 2 8.3C2 8.72 2.34 9.05 2.75 9.05H4V11.25H2.75C2.34 11.25 2 11.58 2 12C2 12.41 2.34 12.75 2.75 12.75H4V14.95H2.75C2.34 14.95 2 15.28 2 15.7C2 16.11 2.34 16.45 2.75 16.45H4.23C4.7 18.04 5.96 19.29 7.56 19.77V21.25C7.56 21.66 7.89 22 8.31 22C8.72 22 9.06 21.66 9.06 21.25V20H11.26V21.25C11.26 21.66 11.59 22 12.01 22C12.42 22 12.76 21.66 12.76 21.25V20H14.95V21.25C14.95 21.66 15.29 22 15.7 22C16.11 22 16.45 21.66 16.45 21.25V19.77C18.04 19.29 19.29 18.04 19.77 16.45H21.25C21.67 16.45 22 16.11 22 15.7C22 15.28 21.67 14.95 21.25 14.95H20V12.75H21.25ZM17.26 14.26C17.26 15.91 15.91 17.26 14.26 17.26H9.74C8.09 17.26 6.74 15.91 6.74 14.26V9.74C6.74 8.09 8.09 6.74 9.74 6.74H14.26C15.91 6.74 17.26 8.09 17.26 9.74V14.26Z\' />\n</g>\n\n<g id=\'icon_input\'>\n  <path d=\'M3 6L6 6L6 12L10 12L10 6L13 6V5L8 0L3 5L3 6Z\' />\n  <path d=\'M2 16L14 16V14L2 14V16Z\' />\n</g>\n\n<g id=\'icon_output\'>\n  <path d=\'M13 9H10V16H6V9L3 9V8L8 3L13 8V9Z\' />\n  <path d=\'M14 2H2V0H14V2Z\' />\n</g>\n\n</defs>\n<rect x=\'0\' y=\'27\' width=\'298\' height=\'50\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'301\' y=\'27\' width=\'64\' height=\'50\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'395\' y=\'27\' width=\'200\' height=\'50\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'368\' y=\'27\' width=\'24\' height=\'50\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'598\' y=\'27\' width=\'682\' height=\'50\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<circle cx=\'8\' cy=\'52\' r=\'7\' stroke=\'var(--stage-main, #F2F2F2)\' stroke-width=\'1\' fill=\'var(--stage-clone, #D9D9D9)\' />\n<text text-anchor=\'middle\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'8\' y=\'56\'>1</text>\n<g><title>Memory 0%, 2.00MB</title>\n<use href=\'#icon_memory\' transform=\'translate(395 29) scale(0.6 0.6)\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n  <rect x=\'413\' y=\'29\' width=\'1\' height=\'14\' stroke-width=\'0\' fill=\'var(--mem-light, #AA7785)\'/>  <polygon points=\'413,29 413,29 414,29 414,43 413,43\' stroke=\'none\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n<rect x=\'413\' y=\'32\' width=\'33\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'40\'>2.00MB</text>\n</g>\n<g><title>CPU Usage 21%, 177us</title>\n<use href=\'#icon_cpu\' transform=\'translate(395 45) scale(0.6 0.6)\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n  <rect x=\'413\' y=\'45\' width=\'50\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,45 438,45 463,45 463,59 413,59\' stroke=\'none\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n<rect x=\'413\' y=\'48\' width=\'28\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'56\'>177us</text>\n</g>\n<g><title>Input 100%, 33B, Rows 100%, 2, Width 16B</title>\n<use href=\'#icon_input\' transform=\'translate(395 61) scale(0.9 0.9)\' fill=\'var(--input-medium, #5A8183)\'/>\n  <rect x=\'413\' y=\'61\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--input-light, #7CA3A5)\'/>  <polygon points=\'413,61 503,61 593,61 593,75 413,75\' stroke=\'none\' fill=\'var(--input-medium, #5A8183)\'/>\n<rect x=\'413\' y=\'64\' width=\'16\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'72\'>33B</text>\n</g>\n<g><title>Input, Duration: 0.00 (0.01 | 0.01 | 0.01 - 0.01 | 0.01 | 0.01)</title><rect x=\'604\' y=\'61\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--input-medium, #5A8183)\'/>\n</g>\n<rect x=\'0\' y=\'80\' width=\'298\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'301\' y=\'80\' width=\'64\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'395\' y=\'80\' width=\'200\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'368\' y=\'80\' width=\'24\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'598\' y=\'80\' width=\'682\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<circle cx=\'8\' cy=\'113\' r=\'7\' stroke=\'var(--stage-main, #F2F2F2)\' stroke-width=\'1\' fill=\'var(--stage-clone, #D9D9D9)\' />\n<text text-anchor=\'middle\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'8\' y=\'117\'>0</text>\n<g><title>Output Rows 50%, 2</title>\n  <rect x=\'303\' y=\'86\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,86 333,86 363,86 363,100 303,100\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'89\' width=\'5\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'303\' y=\'97\'>2</text>\n</g>\n<g><title>Output Rows 50%, 2, Est: 1.08K Rows: 55 Size: 2.36KB</title>\n  <rect x=\'303\' y=\'106\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,106 333,106 363,106 363,120 303,120\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'109\' width=\'5\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'303\' y=\'117\'>2</text>\n</g>\n<g><title>Output 100%, 33B, Rows 100%, 2</title>\n<use href=\'#icon_output\' transform=\'translate(395 82) scale(0.9 0.9)\' fill=\'var(--output-medium, #5781B9)\'/>\n  <rect x=\'413\' y=\'82\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'413,82 503,82 593,82 593,96 413,96\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'413\' y=\'85\' width=\'16\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'93\'>33B</text>\n</g>\n<g><title>Output, Duration: 0.00 (0.01 | 0.01 | 0.01 - 0.01 | 0.01 | 0.01)</title><rect x=\'604\' y=\'82\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-medium, #5781B9)\'/>\n</g>\n<g><title>Memory 99%, 201.00MB</title>\n<use href=\'#icon_memory\' transform=\'translate(395 98) scale(0.6 0.6)\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n  <rect x=\'413\' y=\'98\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--mem-light, #AA7785)\'/>  <polygon points=\'413,98 503,98 593,98 593,112 413,112\' stroke=\'none\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n<rect x=\'413\' y=\'101\' width=\'44\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'109\'>201.00MB</text>\n</g>\n<g><title>CPU Usage 78%, 628us</title>\n<use href=\'#icon_cpu\' transform=\'translate(395 114) scale(0.6 0.6)\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n  <rect x=\'413\' y=\'114\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,114 503,114 593,114 593,128 413,128\' stroke=\'none\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n<rect x=\'413\' y=\'117\' width=\'28\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'125\'>628us</text>\n</g>\n<g><title>Ingress 100%, 1.59KB, Rows 100%, 2, Width 819B</title>\n<use href=\'#icon_input\' transform=\'translate(395 130) scale(0.9 0.9)\' fill=\'var(--ingress-medium, #466364)\'/>\n  <rect x=\'413\' y=\'130\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--ingress-light, #5A8183)\'/>  <polygon points=\'413,130 503,130 593,130 593,144 413,144\' stroke=\'none\' fill=\'var(--ingress-medium, #466364)\'/>\n<rect x=\'413\' y=\'133\' width=\'33\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'141\'>1.59KB</text>\n</g>\n<g><title>Ingress, Duration: 0.00 (0.01 | 0.01 | 0.01 - 0.01 | 0.01 | 0.01)</title><rect x=\'604\' y=\'130\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--ingress-medium, #466364)\'/>\n</g>\n\n<line x1=\'600\' y1=\'0\' x2=\'600\' y2=\'146\' stroke-width=\'1\' stroke=\'var(--stage-grid, #B2B2B2)\' stroke-dasharray=\'1,2\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'602\' y=\'11\'>0:00</text>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'0\' y=\'11\'>Sink</text>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'303\' y=\'11\'>Operators</text>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'397\' y=\'11\'>Stages</text>\n<text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'390\' y=\'11\'>Tasks</text>\n<text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'390\' y=\'22\'>2</text>\n<g><title>Ingress 1.59KB, Rows 2, Width 819B, Avg 1.59KB/s</title>\n  <rect x=\'395\' y=\'14\' width=\'65\' height=\'10\' stroke-width=\'0\' fill=\'var(--ingress-medium, #466364)\'/>\n  <text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-light, #FFFFFF)\' x=\'397\' y=\'22\'>1.59KB</text>\n</g>\n<g><title>CPU Usage 805us, Avg 0.00 CPU/s</title>\n  <rect x=\'462\' y=\'14\' width=\'66\' height=\'10\' stroke-width=\'0\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n  <text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-light, #FFFFFF)\' x=\'464\' y=\'22\'>805us</text>\n</g>\n<g><title>Memory 203.00MB</title>\n  <rect x=\'530\' y=\'14\' width=\'65\' height=\'10\' stroke-width=\'0\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n  <text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-light, #FFFFFF)\' x=\'532\' y=\'22\'>203.00MB</text>\n</g>\n<g><title>Duration: 1.00, Total 1.00</title>\n  <rect x=\'1215\' y=\'3\' width=\'65\' height=\'10\' stroke-width=\'0\' fill=\'var(--stage-grid, #B2B2B2)\'/>\n  <text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-inv, #FFFFFF)\' x=\'1278\' y=\'11\'>1.00</text>\n</g>\n<g><title>Max CPU 0.96</title>\n<polygon points=\'598,26 598,26 598,26 598,26 598,26 599,26 599,26 600,26 600,26 600,26 600,26 601,26 601,26 602,26 602,26 602,26 602,26 603,26 603,26 604,26 604,13 604,26 604,26 605,26 605,26 606,26 606,26 606,26 606,26 607,26 607,26 608,26 608,26 608,26 608,26 \' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n<g><title>Stage: </title>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'18\' y=\'38\'>Stage</text>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'22\' y=\'48\'></text></g>\n<g><title>Stage 1, tasks: 1, finished: 1</title>\n<line x1=\'371\' y1=\'27\' x2=\'371\' y2=\'77\' stroke-width=\'6\' stroke=\'var(--stage-text, #262626)\' stroke-dasharray=\'1,1\' />\n  <text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'390\' y=\'56\'>1</text>\n</g>\n<g><title>Max MEM 2.00MB</title>\n<polygon points=\'598,42 598,29 608,29 608,42 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 0.11</title>\n<polygon points=\'598,58 598,58 598,58 598,58 598,58 599,58 599,58 600,58 600,58 600,58 600,58 601,58 601,58 602,58 602,58 602,58 602,58 603,58 603,58 604,58 604,58 604,58 604,58 605,58 605,58 606,58 606,58 606,58 606,58 607,58 607,58 608,58 608,45 608,58 608,58 \' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n<g><title>Connection: Map</title>\n  <polygon points=\'16,94 0,94 0,80 8,76 16,80\' stroke-width=\'1\' stroke=\'var(--conn-line, #BFBFBF)\' fill=\'var(--conn-fill, #BFBFBF)\'/>\n  <text text-anchor=\'middle\' font-family=\'Verdana\' font-size=\'6px\' fill=\'var(--conn-text, #393939)\' x=\'8\' y=\'90\'>Ma</text>\n</g>\n<g><title>Stage: </title>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'18\' y=\'91\'>Stage</text>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'22\' y=\'101\'></text></g>\n<line x1=\'18\' y1=\'103\' x2=\'298\' y2=\'103\' stroke-width=\'1\' stroke=\'var(--stage-grid, #B2B2B2)\' stroke-dasharray=\'1,2\'/>\n<g><title>Source s3: h8810004111901439312_test_date_time_simple_format_insertmy_binding(Fruit, Price, Time, Weight)</title>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'18\' y=\'111\'>Source s3</text>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'22\' y=\'121\'>h8810004111901439312_test_date_time_simple_format_insertmy_binding(Fruit, Price, Time, Weight)</text></g>\n<g><title>Stage 0, tasks: 1, finished: 1</title>\n<line x1=\'371\' y1=\'80\' x2=\'371\' y2=\'146\' stroke-width=\'6\' stroke=\'var(--stage-text, #262626)\' stroke-dasharray=\'1,1\' />\n  <text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'390\' y=\'117\'>1</text>\n</g>\n<g><title>Max MEM 201.00MB</title>\n<polygon points=\'598,111 598,98 604,98 604,111 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 1.54</title>\n<polygon points=\'598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 599,127 599,127 599,127 600,127 600,127 600,127 600,127 600,127 600,127 601,127 601,127 601,127 601,127 602,127 602,127 602,127 602,127 602,127 602,127 603,127 603,127 603,127 604,127 604,127 604,114 604,127 604,127 \' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n\n</svg>\n"
  }
}

2025-12-12 13:28:17,303 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:28:17,308 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:28:17,310 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:28:17,310 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:28:17,312 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:28:17,315 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:28:17,321 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:28:17,323 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-12-12 13:28:17,326 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-12-12 13:28:17,329 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-12-12 13:28:17,331 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7f3737982090>
2025-12-12 13:28:17,332 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-12-12 13:28:17,334 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function set_list_objects_encoding_type_url at 0x7f3738f587d0>
2025-12-12 13:28:17,337 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:17,337 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:17,341 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,342 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:17,345 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:17,347 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,347 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:17,350 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:17,350 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:17,350 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:17,351 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:17,351 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:17,355 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:17,355 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=ListObjects) with params: {'url_path': '', 'query_string': {'encoding-type': 'url'}, 'method': 'GET', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource'}, 'body': b'', 'auth_path': '/fbucket/', 'url': 'http://localhost:24309/fbucket?encoding-type=url', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f37381c6360>, 'has_streaming_input': False, 'auth_type': 'v4', 'encoding_type_auto_set': True, 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'EncodingType': 'url'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:17,358 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f37381c4b50>>
2025-12-12 13:28:17,360 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b271a50>>
2025-12-12 13:28:17,360 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:17,362 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:17,362 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:17,362 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132817Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:28:17,362 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132817Z
20251212/yandex/s3/aws4_request
bb05c828bbdfb52c1c07455518bcc435b34dd415fdcefb6c1bd1d30673372451
2025-12-12 13:28:17,362 - DEBUG - botocore.auth - add_auth: Signature:
110e85fd1ef2c814cd24f04d83cb6f86f1f977d8462d116db0597668dde486fe
2025-12-12 13:28:17,363 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:17,363 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=GET, url=http://localhost:24309/fbucket?encoding-type=url, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'X-Amz-Date': b'20251212T132817Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=110e85fd1ef2c814cd24f04d83cb6f86f1f977d8462d116db0597668dde486fe', 'amz-sdk-invocation-id': b'a27a29db-4238-4ef0-b211-f1e5e2f620a1', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:28:17,370 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:17 GMT', 'x-amzn-requestid': 'N0WMZt2hKdH6oF3Uaa4nZ1kGGZIY1CjH8ghSaEtpcDsl1RtfZRfp', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '987', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:17,373 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>fbucket</Name><MaxKeys>1000</MaxKeys><EncodingType>url</EncodingType><IsTruncated>false</IsTruncated><Contents><Key>common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet</Key><LastModified>2025-12-12T13:28:16.000Z</LastModified><ETag>&#34;ac6835fb183202e820103e8dae2c52c3&#34;</ETag><Size>1125</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>common/simple_format/test.parquet</Key><LastModified>2025-12-12T13:28:16.000Z</LastModified><ETag>&#34;021571fe1ebad35715c80e226d65f113&#34;</ETag><Size>1089</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-12-12 13:28:17,375 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b255e10>
2025-12-12 13:28:17,375 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:17,376 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,376 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7f3738f58890>
2025-12-12 13:28:17,376 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-12-12 13:28:17,376 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-12-12 13:28:17,377 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7f3737982210>
2025-12-12 13:28:17,378 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:28:17,382 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3738154510>}) about to wait for the following futures []
2025-12-12 13:28:17,384 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3738154510>}) done waiting for dependent futures
2025-12-12 13:28:17,385 - DEBUG - s3transfer.tasks - _execute_main: Executing task DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3738154510>}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b226130>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7f3738136680>, 'osutil': <s3transfer.utils.OSUtils object at 0x7f3738135f00>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7f3738136e50>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f3738154510>, 'io_executor': <s3transfer.futures.BoundedExecutor object at 0x7f3738154740>}
2025-12-12 13:28:17,389 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:28:17,390 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:17,390 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:17,390 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,392 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:17,393 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:17,395 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,398 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:17,398 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:17,402 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:17,402 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:17,403 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:17,404 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:17,409 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:17,410 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=HeadObject) with params: {'url_path': '/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'query_string': {}, 'method': 'HEAD', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource'}, 'body': b'', 'auth_path': '/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'url': 'http://localhost:24309/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f37381c6360>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:17,413 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:28:17,413 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f37381c4b50>>
2025-12-12 13:28:17,415 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.HeadObject: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b271a50>>
2025-12-12 13:28:17,416 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.HeadObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:17,416 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.HeadObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:17,419 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:17,424 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
HEAD
/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet

host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132817Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:28:17,424 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132817Z
20251212/yandex/s3/aws4_request
a195f30227f5f7a2601297b424db1a71545dde6d8d9d38008b3c25f0523bb1fb
2025-12-12 13:28:17,425 - DEBUG - botocore.auth - add_auth: Signature:
5b0f9fdb9394a322052b4a74f3368edf225efa0680026e9691491fd85670c38d
2025-12-12 13:28:17,425 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:28:17,428 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:17,429 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=HEAD, url=http://localhost:24309/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'X-Amz-Date': b'20251212T132817Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=5b0f9fdb9394a322052b4a74f3368edf225efa0680026e9691491fd85670c38d', 'amz-sdk-invocation-id': b'4871db7e-9a27-40ab-8703-85752fdc7f40', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:28:17,439 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:17 GMT', 'content-type': 'binary/octet-stream', 'ETag': '"ac6835fb183202e820103e8dae2c52c3"', 'last-modified': 'Fri, 12 Dec 2025 13:28:16 GMT', 'Content-Length': '1125', 'x-amzn-requestid': 'AS9v9H41TvLuj9ro8wMn3XMOducverw1P01eU3Yceu2HfmX8QYFq', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:17,440 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-12-12 13:28:17,441 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b255e10>
2025-12-12 13:28:17,442 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:17,442 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,442 - DEBUG - s3transfer.futures - submit: Submitting task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7f3738136e50> for transfer request: 0.
2025-12-12 13:28:17,443 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:28:17,443 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'extra_args': {}}) about to wait for the following futures []
2025-12-12 13:28:17,444 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:28:17,444 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'extra_args': {}}) done waiting for dependent futures
2025-12-12 13:28:17,445 - DEBUG - s3transfer.tasks - _execute_main: Executing task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b226130>, 'bucket': 'fbucket', 'key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'fileobj': <_io.BytesIO object at 0x7f3737b7a5f0>, 'extra_args': {}, 'callbacks': [], 'max_attempts': 5, 'download_output_manager': <s3transfer.download.DownloadSeekableOutputManager object at 0x7f3738135230>, 'io_chunksize': 262144, 'bandwidth_limiter': None}
2025-12-12 13:28:17,448 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:28:17,454 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:28:17,464 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f3738f59790>
2025-12-12 13:28:17,464 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,465 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:28:17,465 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:28:17,466 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,466 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:24309', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-12-12 13:28:17,466 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:28:17,466 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selecting from endpoint provider's list of auth schemes: "sigv4". User selected auth scheme is: "None"
2025-12-12 13:28:17,467 - DEBUG - botocore.regions - auth_schemes_to_signing_ctx: Selected auth type "v4" as "v4" with signing context params: {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}
2025-12-12 13:28:17,468 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:28:17,468 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:28:17,468 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:28:17,468 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=GetObject) with params: {'url_path': '/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'query_string': {}, 'method': 'GET', 'headers': {'User-Agent': 'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource'}, 'body': b'', 'auth_path': '/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'url': 'http://localhost:24309/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f37381c6360>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:28:17,470 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:28:17,470 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f37381c4b50>>
2025-12-12 13:28:17,470 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.GetObject: calling handler <bound method ClientCreator._default_s3_presign_to_sigv2 of <botocore.client.ClientCreator object at 0x7f371b271a50>>
2025-12-12 13:28:17,479 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.GetObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:28:17,479 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.GetObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:28:17,483 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:28:17,486 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet

host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132817Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:28:17,487 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132817Z
20251212/yandex/s3/aws4_request
5ff7a14b1eb93fe666574a5ca96d2520310e1e522e5d4cfe1bc75a6bebcbdcf3
2025-12-12 13:28:17,487 - DEBUG - botocore.auth - add_auth: Signature:
bbf2f840890ae39f06913992fc2121c6b28131494efa64e523d1793251454ffb
2025-12-12 13:28:17,487 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:28:17,491 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:28:17,491 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=True, method=GET, url=http://localhost:24309/fbucket/common/simple_format/parquet/ptjudq7r212qljfs66h6_0_5twLKqNZfUWlZ8BP5q6F-YQdBRXEMBAW.parquet, headers={'User-Agent': b'Boto3/1.29.6 md/Botocore#1.31.80 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.9 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.31.80 Resource', 'X-Amz-Date': b'20251212T132817Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=bbf2f840890ae39f06913992fc2121c6b28131494efa64e523d1793251454ffb', 'amz-sdk-invocation-id': b'fcf94d2b-4fb7-409b-95f7-241e7fd58ba7', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:28:17,500 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:28:17 GMT', 'x-amz-version-id': 'null', 'content-type': 'binary/octet-stream', 'ETag': '"ac6835fb183202e820103e8dae2c52c3"', 'last-modified': 'Fri, 12 Dec 2025 13:28:16 GMT', 'Content-Length': '1125', 'x-amzn-requestid': 'EIkrRx5bz739j5S8x680ecgtjwl6MWKE91vZuy0FS5NoX0i1hpNU', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:28:17,500 - DEBUG - botocore.parsers - parse: Response body:
<botocore.response.StreamingBody object at 0x7f371ab14e60>
2025-12-12 13:28:17,502 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b255e10>
2025-12-12 13:28:17,504 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:28:17,506 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b01e130>>
2025-12-12 13:28:17,507 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) about to wait for the following futures []
2025-12-12 13:28:17,508 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) done waiting for dependent futures
2025-12-12 13:28:17,508 - DEBUG - s3transfer.tasks - _execute_main: Executing task IOWriteTask(transfer_id=0, {'offset': 0}) with kwargs {'fileobj': <_io.BytesIO object at 0x7f3737b7a5f0>, 'offset': 0}
2025-12-12 13:28:17,516 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) about to wait for the following futures []
2025-12-12 13:28:17,518 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) done waiting for dependent futures
2025-12-12 13:28:17,519 - DEBUG - s3transfer.tasks - _execute_main: Executing task CompleteDownloadNOOPTask(transfer_id=0, {}) with kwargs {}
2025-12-12 13:28:17,521 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:28:17,538 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-12-12 13:31:28,636 - DEBUG - ya.test - _verify_test: Verifying [test_format_setting.TestS3.test_date_time_simple_format_insert[v2-common/simple_format/test.parquet-parquet] in ydb/tests/fq/s3] canonical results
2025-12-12 13:31:28,643 - DEBUG - ya.test - verify: Test test_format_setting.TestS3.test_date_time_simple_format_insert[v2-common/simple_format/test.parquet-parquet] status: good
