2025-12-12 13:27:29,414 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 13:27:29,414 - INFO - ya.test - pytest_runtest_setup: test_timestamp_unix_time_insert[v2-timestamp/unix_time/test.json-json_each_row-UNIX_TIME_MICROSECONDS]
2025-12-12 13:27:29,414 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 13:27:29,414 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-12 13:27:29,508 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_format_setting.py::TestS3, test_name: test_timestamp_unix_time_insert[v2-timestamp/unix_time/test.json-json_each_row-UNIX_TIME_MICROSECONDS])
2025-12-12 13:27:29,509 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:27:29,515 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:27:29,515 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:27:29,515 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:27:29,519 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:27:29,524 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:27:29,525 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:27:29,527 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-12-12 13:27:29,529 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-12-12 13:27:29,530 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-12-12 13:27:29,532 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7f3737982090>
2025-12-12 13:27:29,533 - DEBUG - boto3.resources.action - __call__: Calling s3:create_bucket with {'Bucket': 'fbucket', 'ACL': 'public-read'}
2025-12-12 13:27:29,535 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:29,536 - 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:27:29,536 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,536 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:29,536 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:29,537 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,537 - 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:27:29,539 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:29,539 - 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:27:29,539 - 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:27:29,540 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:29,541 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:29,541 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:29,541 - 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 0x7f37381442e0>, '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:27:29,542 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f3738146040>>
2025-12-12 13:27:29,542 - 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 0x7f371b1f56e0>>
2025-12-12 13:27:29,543 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.CreateBucket: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:29,543 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.CreateBucket: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:29,544 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:29,544 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket

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

host;x-amz-acl;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:27:29,544 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132729Z
20251212/yandex/s3/aws4_request
cdb660cb3f57a5af83b407cecb7e4cc5e43105830e52d8dd30c948a04052d636
2025-12-12 13:27:29,545 - DEBUG - botocore.auth - add_auth: Signature:
96268b776c55276076329355f39dd710192d9507e96f652a3d9ae83af740c293
2025-12-12 13:27:29,545 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:29,545 - 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'20251212T132729Z', '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=96268b776c55276076329355f39dd710192d9507e96f652a3d9ae83af740c293', 'amz-sdk-invocation-id': b'c146de77-6d01-43fe-82c0-49e1bca21320', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2025-12-12 13:27:29,557 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'x-amzn-requestid': 'IoWl4Zp3y7rCmSXBJ2K3uogO5yiGHljiKyb5gWunaaFDLBaZYj7y', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '161', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:29,557 - 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:27:29,558 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b882db0>
2025-12-12 13:27:29,559 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:29,559 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,559 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'IoWl4Zp3y7rCmSXBJ2K3uogO5yiGHljiKyb5gWunaaFDLBaZYj7y', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'x-amzn-requestid': 'IoWl4Zp3y7rCmSXBJ2K3uogO5yiGHljiKyb5gWunaaFDLBaZYj7y', 'content-type': 'text/html; charset=utf-8', 'content-length': '161', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}}
2025-12-12 13:27:29,560 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-12-12 13:27:29,561 - 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:27:29,561 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:29,561 - 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:27:29,561 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,561 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:29,562 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:29,562 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,562 - 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:27:29,563 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:29,564 - 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:27:29,564 - 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:27:29,564 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:29,564 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:29,565 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:29,565 - 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 0x7f37381442e0>, '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:27:29,565 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f3738146040>>
2025-12-12 13:27:29,565 - 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 0x7f371b1f56e0>>
2025-12-12 13:27:29,566 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:29,566 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:29,566 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:29,566 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132729Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:27:29,566 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132729Z
20251212/yandex/s3/aws4_request
5788180c5be829416ce27109ea8c6ed400732f08ac93bd361e11c4e462e34492
2025-12-12 13:27:29,567 - DEBUG - botocore.auth - add_auth: Signature:
ba15efd02b1515817db55e543253a876902666afb87a0c8f52d262bef2c8f1d9
2025-12-12 13:27:29,567 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:29,567 - 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'20251212T132729Z', '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=ba15efd02b1515817db55e543253a876902666afb87a0c8f52d262bef2c8f1d9', 'amz-sdk-invocation-id': b'fffa1c28-639f-4209-8f8b-21a34079fa5b', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:27:29,574 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'x-amzn-requestid': 'peRVLKdaGbKJLWBz9z7d6S1RZnCL3Pb40u3F0pSWvUT1ZTHeMUgD', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '983', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:29,574 - 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>timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json</Key><LastModified>2025-12-12T13:27:28.000Z</LastModified><ETag>&#34;962fb8bb880cca306b1aa78f70e18c10&#34;</ETag><Size>167</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>timestamp/unix_time/test.json</Key><LastModified>2025-12-12T13:27:28.000Z</LastModified><ETag>&#34;56ede7cef02efaa4d249186b9f224769&#34;</ETag><Size>260</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-12-12 13:27:29,576 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b882db0>
2025-12-12 13:27:29,577 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:29,577 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,577 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7f3738f58890>
2025-12-12 13:27:29,577 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-12-12 13:27:29,578 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-12-12 13:27:29,579 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7f3737982210>
2025-12-12 13:27:29,580 - DEBUG - boto3.resources.action - __call__: Calling s3:delete_objects with {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json'}, {'Key': 'timestamp/unix_time/test.json'}]}}
2025-12-12 13:27:29,581 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:29,581 - 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:27:29,581 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,581 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:29,582 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:29,582 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,582 - 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:27:29,583 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:29,583 - 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:27:29,583 - 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:27:29,584 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function escape_xml_payload at 0x7f3738f328d0>
2025-12-12 13:27:29,585 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:29,585 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:29,585 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:29,585 - 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': 'F7dDR2pE60b+PXdn8Tpg+Q=='}, 'body': b'<Delete xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Object><Key>timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json</Key></Object><Object><Key>timestamp/unix_time/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 0x7f37381442e0>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json'}, {'Key': 'timestamp/unix_time/test.json'}]}}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'checksum': {'request_algorithm': 'conditional-md5'}}}
2025-12-12 13:27:29,586 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f3738146040>>
2025-12-12 13:27:29,587 - 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 0x7f371b1f56e0>>
2025-12-12 13:27:29,587 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.DeleteObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:29,587 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.DeleteObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:29,588 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:29,588 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
POST
/fbucket
delete=
content-md5:F7dDR2pE60b+PXdn8Tpg+Q==
host:localhost:24309
x-amz-content-sha256:946db1a48762506bf0393aecc72d2d5d81f7777f2cd438b18e80d9d5db92789e
x-amz-date:20251212T132729Z

content-md5;host;x-amz-content-sha256;x-amz-date
946db1a48762506bf0393aecc72d2d5d81f7777f2cd438b18e80d9d5db92789e
2025-12-12 13:27:29,588 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132729Z
20251212/yandex/s3/aws4_request
a6a9981a45d3a580ae290f8b37b695ed69d830236856296f5d27923bbfc985f0
2025-12-12 13:27:29,588 - DEBUG - botocore.auth - add_auth: Signature:
b54c0928300e428c1eb38887219f95e6e6634f006f2af0fe05c1a851203b45b4
2025-12-12 13:27:29,589 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:29,589 - 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'F7dDR2pE60b+PXdn8Tpg+Q==', 'X-Amz-Date': b'20251212T132729Z', 'X-Amz-Content-SHA256': b'946db1a48762506bf0393aecc72d2d5d81f7777f2cd438b18e80d9d5db92789e', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=b54c0928300e428c1eb38887219f95e6e6634f006f2af0fe05c1a851203b45b4', 'amz-sdk-invocation-id': b'9d8b3a0e-3806-4721-af7b-52b2f8484e7f', 'amz-sdk-request': b'attempt=1', 'Content-Length': '244'}>
2025-12-12 13:27:29,596 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'x-amzn-requestid': '2v5tUkrMvMAVG7FflWwYBTK8pJYokoChaZpWHUbHD0Ya2B4sVJHY', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '297', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:29,596 - 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>timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json</Key></Deleted><Deleted><Key>timestamp/unix_time/test.json</Key></Deleted></DeleteResult>'
2025-12-12 13:27:29,597 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371b882db0>
2025-12-12 13:27:29,597 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:29,597 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737b38ce0>>
2025-12-12 13:27:29,597 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': '2v5tUkrMvMAVG7FflWwYBTK8pJYokoChaZpWHUbHD0Ya2B4sVJHY', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'x-amzn-requestid': '2v5tUkrMvMAVG7FflWwYBTK8pJYokoChaZpWHUbHD0Ya2B4sVJHY', 'content-type': 'text/html; charset=utf-8', 'content-length': '297', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}, 'Deleted': [{'Key': 'timestamp/unix_time/json_each_row/ptjudq7r3eukqnon8h2t_0_dd7mr5tXMkaq5C6N1kPW3T9LX2-qCsOf.json'}, {'Key': 'timestamp/unix_time/test.json'}]}
2025-12-12 13:27:29,598 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:27:29,600 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:27:29,600 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:27:29,600 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:27:29,603 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:27:29,607 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:27:29,608 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:27:29,610 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:27:29,610 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371aeee1d0>}) about to wait for the following futures []
2025-12-12 13:27:29,611 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371aeee1d0>}) done waiting for dependent futures
2025-12-12 13:27:29,611 - DEBUG - s3transfer.tasks - _execute_main: Executing task UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371aeee1d0>}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b9f0ce0>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7f3737b39aa0>, 'osutil': <s3transfer.utils.OSUtils object at 0x7f371b9f27c0>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7f371abf5fa0>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371aeee1d0>}
2025-12-12 13:27:29,611 - DEBUG - s3transfer.futures - submit: Submitting task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/test.json', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7f371abf5fa0> for transfer request: 0.
2025-12-12 13:27:29,612 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:27:29,612 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/test.json', 'extra_args': {}}) about to wait for the following futures []
2025-12-12 13:27:29,612 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:27:29,612 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/test.json', 'extra_args': {}}) done waiting for dependent futures
2025-12-12 13:27:29,613 - DEBUG - s3transfer.tasks - _execute_main: Executing task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/test.json', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b9f0ce0>, 'fileobj': <s3transfer.utils.ReadFileChunk object at 0x7f371aeee090>, 'bucket': 'fbucket', 'key': 'timestamp/unix_time/test.json', 'extra_args': {}}
2025-12-12 13:27:29,614 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_ascii_metadata at 0x7f3738f33f50>
2025-12-12 13:27:29,614 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:27:29,614 - 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:27:29,614 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:29,614 - 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:27:29,614 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737be9640>>
2025-12-12 13:27:29,614 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:29,615 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:29,615 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737be9640>>
2025-12-12 13:27:29,615 - 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:27:29,616 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:29,616 - 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:27:29,617 - 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:27:29,617 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function conditionally_calculate_md5 at 0x7f373914fe90>
2025-12-12 13:27:29,618 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:29,618 - DEBUG - botocore.handlers - add_expect_header: Adding expect 100 continue header to request.
2025-12-12 13:27:29,618 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:29,618 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:29,618 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=PutObject) with params: {'url_path': '/timestamp/unix_time/test.json', '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': 'Vu3nzvAu+qTSSRhrnyJHaQ==', 'Expect': '100-continue'}, 'body': <s3transfer.utils.ReadFileChunk object at 0x7f371aeee090>, 'auth_path': '/fbucket/timestamp/unix_time/test.json', 'url': 'http://localhost:24309/fbucket/timestamp/unix_time/test.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f3737be9230>, 'has_streaming_input': True, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'timestamp/unix_time/test.json', 'Body': <s3transfer.utils.ReadFileChunk object at 0x7f371aeee090>}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:27:29,619 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:27:29,620 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f3737be9c80>>
2025-12-12 13:27:29,620 - 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 0x7f371ab633a0>>
2025-12-12 13:27:29,620 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.PutObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:29,621 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.PutObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:29,621 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:29,621 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket/timestamp/unix_time/test.json

content-md5:Vu3nzvAu+qTSSRhrnyJHaQ==
host:localhost:24309
x-amz-content-sha256:9f07d5faf3bf04bd8da7f72fcbcfdd357fe4f701fd500cb997764ba60947da94
x-amz-date:20251212T132729Z

content-md5;host;x-amz-content-sha256;x-amz-date
9f07d5faf3bf04bd8da7f72fcbcfdd357fe4f701fd500cb997764ba60947da94
2025-12-12 13:27:29,621 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132729Z
20251212/yandex/s3/aws4_request
cb46bb9b16b77b2e9da7452eb71834bd43040cf7585d339ce5871b9c3c8d6aee
2025-12-12 13:27:29,622 - DEBUG - botocore.auth - add_auth: Signature:
b3545e29f7142eacddca85d814bf921e5b23a5e1697cb2a2d9ec7ab7e5ed389f
2025-12-12 13:27:29,622 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:27:29,622 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:29,622 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:24309/fbucket/timestamp/unix_time/test.json, 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'Vu3nzvAu+qTSSRhrnyJHaQ==', 'Expect': b'100-continue', 'X-Amz-Date': b'20251212T132729Z', 'X-Amz-Content-SHA256': b'9f07d5faf3bf04bd8da7f72fcbcfdd357fe4f701fd500cb997764ba60947da94', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251212/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=b3545e29f7142eacddca85d814bf921e5b23a5e1697cb2a2d9ec7ab7e5ed389f', 'amz-sdk-invocation-id': b'7bceef35-7e76-453c-9d16-1be83426e1c7', 'amz-sdk-request': b'attempt=1', 'Content-Length': '260'}>
2025-12-12 13:27:29,624 - DEBUG - botocore.awsrequest - _send_output: Waiting for 100 Continue response.
2025-12-12 13:27:29,625 - DEBUG - botocore.awsrequest - _handle_expect_response: 100 Continue response seen, now sending request body.
2025-12-12 13:27:29,629 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:29 GMT', 'ETag': '"56ede7cef02efaa4d249186b9f224769"', 'last-modified': 'Fri, 12 Dec 2025 13:27:29 GMT', 'Content-Length': '0', 'x-amzn-requestid': 'Eamp2RbxJ5Ghsme3KznqOohgdZggtuKLNsrrYac7dzXig6P4Dpf9', 'Content-Type': 'text/html; charset=utf-8', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:29,629 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-12-12 13:27:29,630 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f371abf62c0>
2025-12-12 13:27:29,630 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:29,630 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f3737be9640>>
2025-12-12 13:27:29,631 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:27:29,632 - DEBUG - root - wait_bootstrap: Wait for node 1 to bootstrap
2025-12-12 13:27:29,658 - DEBUG - root - wait_bootstrap: Node 1 has been bootstrapped
2025-12-12 13:27:29,870 - DEBUG - root - create_query_impl: Request: content {
  type: ANALYTICS
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO bindings.`h5616066189875708492_test_timestamp_unix_time_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h5616066189875708492_test_timestamp_unix_time_insertmy_binding`\n            "
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "8e1650f4-37f3-4fae-b9c6-d66f5cc6f6cd"

2025-12-12 13:27:29,899 - DEBUG - root - create_query_impl: Result: query_id: "ptqudq7r3dpkp7lo5d2n"

2025-12-12 13:27:29,912 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7r3dpkp7lo5d2n"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765546049
        nanos: 875131000
      }
      modified_at {
        seconds: 1765546049
        nanos: 875131000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudq7r3dpknrkbcqud-ptqudq7r3dpkp7lo5d2n"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765546049
      nanos: 875131000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h5616066189875708492_test_timestamp_unix_time_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h5616066189875708492_test_timestamp_unix_time_insertmy_binding`\n            "
    syntax: YQL_V1
  }
}

2025-12-12 13:27:30,433 - DEBUG - root - describe_query: Result: ... (repeated, see above) ...
2025-12-12 13:27:30,953 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7r3dpkp7lo5d2n"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765546049
        nanos: 875131000
      }
      modified_at {
        seconds: 1765546049
        nanos: 875131000
      }
      revision: 1
    }
    started_at {
      seconds: 1765546050
      nanos: 806000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudq7r3dpknrkbcqud-ptqudq7r3dpkp7lo5d2n"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765546049
      nanos: 875131000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h5616066189875708492_test_timestamp_unix_time_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h5616066189875708492_test_timestamp_unix_time_insertmy_binding`\n            "
    syntax: YQL_V1
  }
  statistics {
    json: "{}"
  }
  timeline {
    svg: "<svg width=\'1280\' height=\'0\' xmlns=\'http://www.w3.org/2000/svg\'>\n<clipPath id=\'clipTextPath\'><rect x=\'0\' y=\'0\' width=\'298\' height=\'0\'/></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\n<line x1=\'600\' y1=\'0\' x2=\'600\' y2=\'0\' stroke-width=\'1\' stroke=\'var(--stage-grid, #B2B2B2)\' stroke-dasharray=\'1,2\'/>\n\n</svg>\n"
  }
}

2025-12-12 13:27:31,481 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7r3dpkp7lo5d2n"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765546049
        nanos: 875131000
      }
      modified_at {
        seconds: 1765546049
        nanos: 875131000
      }
      revision: 1
    }
    started_at {
      seconds: 1765546050
      nanos: 806000000
    }
    finished_at {
      seconds: 1765546051
      nanos: 46000000
    }
    execute_mode: RUN
    status: COMPLETED
    last_job_query_revision: 1
    last_job_id: "ptjudq7r3dpknrkbcqud-ptqudq7r3dpkp7lo5d2n"
    result_expire_at {
      seconds: 1765632450
      nanos: 790563000
    }
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765546049
      nanos: 875131000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h5616066189875708492_test_timestamp_unix_time_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h5616066189875708492_test_timestamp_unix_time_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\":\"48.14814815\",\"Format\":\"json_each_row\",\"Name\":\"h5616066189875708492_test_timestamp_unix_time_insertmy_binding\",\"Inputs\":[],\"Path\":\"timestamp/unix_time/test.json \",\"E-Rows\":\"1.094276094\",\"ExternalDataSource\":\"h5616066189875708492_test_timestamp_unix_time_insertfruitbucket\",\"ReadColumns\":[\"Fruit\",\"Price\",\"Time\",\"Weight\"],\"SourceType\":\"s3\",\"E-Cost\":\"260\"}],\"Node Type\":\"Source\"}],\"Node Type\":\"Stage\"}],\"Node Type\":\"Map\",\"PlanNodeType\":\"Connection\"}],\"Node Type\":\"Stage\"}],\"Operators\":[{\"Inputs\":[],\"ExternalDataSource\":\"h5616066189875708492_test_timestamp_unix_time_insertfruitbucket\",\"Extension\":\".json\",\"Name\":\"Write h5616066189875708492_test_timestamp_unix_time_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\":\"479us\",\"count\":2,\"avg\":\"239us\",\"max\":\"266us\",\"min\":\"213us\"},\"IngressBytes\":{\"sum\":260,\"count\":1,\"avg\":260,\"max\":260,\"min\":260},\"IngressRows\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"InputBytes\":{\"sum\":48,\"count\":1,\"avg\":48,\"max\":48,\"min\":48},\"InputRows\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputBytes\":{\"sum\":48,\"count\":1,\"avg\":48,\"max\":48,\"min\":48},\"OutputRows\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"EgressBytes\":{\"sum\":185,\"count\":1,\"avg\":185,\"max\":185,\"min\":185},\"EgressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"MaxMemoryUsage\":{\"sum\":211812352,\"count\":2,\"avg\":105906176,\"max\":210763776,\"min\":1048576}}}"
  }
  ast {
    data: "(\n(let $1 \'\"/local/h5616066189875708492_test_timestamp_unix_time_insertfruitbucket\")\n(let $2 \'\"/local/h5616066189875708492_test_timestamp_unix_time_insertmy_binding\")\n(let $3 (DataSource \'\"s3\" $1 $2))\n(let $4 \'\"Paths {\\n  Name: \\\"timestamp\\\"\\n  Children {\\n    Name: \\\"unix_time\\\"\\n    Children {\\n      Name: \\\"test.json\\\"\\n      Size: 260\\n      Read: true\\n    }\\n    IsDirectory: true\\n  }\\n  IsDirectory: true\\n}\\n\")\n(let $5 (Bool \'\"true\"))\n(let $6 \'\"cluster:default_/local/h5616066189875708492_test_timestamp_unix_time_insertfruitbucket\")\n(let $7 (SecureParam $6))\n(let $8 (DataType \'Int32))\n(let $9 (StructType \'(\'\"Fruit\" (DataType \'String)) \'(\'\"Price\" $8) \'(\'\"Time\" (DataType \'Timestamp)) \'(\'\"Weight\" $8)))\n(let $10 \'(\'\"data.timestamp.formatname\" \'\"UNIX_TIME_MICROSECONDS\"))\n(let $11 (S3ParseSettings world \'(\'((String $4) $5 (AsStruct))) $7 \'\"\" \'\"timestamp/unix_time/test.json \" \'\"json_each_row\" $9 (lambda \'($17) $5) \'($10)))\n(let $12 \'(\'(\'\"_logical_id\" \'579) \'(\'\"_id\" \'\"d80554c4-9ae67bb8-6bd1f78-58c05d1e\") \'(\'\"_wide_channels\" $9)))\n(let $13 (DqPhyStage \'((DqSource $3 $11)) (lambda \'($18) (block \'(\n  (let $19 (DqSourceWideWrap $18 $3 $9 \'(\'(\'format \'\"json_each_row\"))))\n  (let $20 (lambda \'($21 $22 $23 $24) $21 $22 (Unwrap (+ $23 (Interval \'\"86400000000\"))) $24))\n  (return (FromFlow (WideMap $19 $20)))\n))) $12))\n(let $14 (DqCnMap (TDqOutput $13 \'\"0\")))\n(let $15 (S3SinkSettings \'\"timestamp/unix_time/json_each_row/\" \'(\'(\'\"multipart\" \'\"true\")) $7 \'\".json\" $9))\n(let $16 (DqPhyStage \'($14) (lambda \'($25) (block \'(\n  (let $26 \'($10 \'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"file_size_limit\" \'\"52428800\")))\n  (return (FromFlow (S3SinkOutput (NarrowMap (ToFlow $25) (lambda \'($27 $28 $29 $30) (AsStruct \'(\'\"Fruit\" $27) \'(\'\"Price\" $28) \'(\'\"Time\" $29) \'(\'\"Weight\" $30)))) \'\"json_each_row\" \'() $26)))\n))) \'(\'(\'\"_logical_id\" \'659) \'(\'\"_id\" \'\"d8a9f570-2acdfb6d-a0d302-e543aafa\")) \'((DqSink \'\"0\" (DataSink \'\"s3\" $1) $15))))\n(return (KqpPhysicalQuery \'((KqpPhysicalTx \'($13 $16) \'() \'() \'(\'(\'\"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%, 1.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=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--mem-light, #AA7785)\'/>  <polygon points=\'413,29 413,29 413,29 413,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\'>1.00MB</text>\n</g>\n<g><title>CPU Usage 55%, 266us</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=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,45 503,45 593,45 593,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\'>266us</text>\n</g>\n<g><title>Input 100%, 48B, Rows 100%, 3, 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\'>48B</text>\n</g>\n<g><title>Input, Duration: 0.00 (0.00 | 0.00 | 0.00 - 0.00 | 0.00 | 0.00)</title><rect x=\'600\' 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%, 3</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\'>3</text>\n</g>\n<g><title>Output Rows 50%, 3, Est: 260 Rows: 1 Size: 48B</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\'>3</text>\n</g>\n<g><title>Output 100%, 48B, Rows 100%, 3</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\'>48B</text>\n</g>\n<g><title>Output, Duration: 0.00 (0.00 | 0.00 | 0.00 - 0.00 | 0.00 | 0.00)</title><rect x=\'600\' 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 44%, 213us</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=\'144\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,114 485,114 557,114 557,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\'>213us</text>\n</g>\n<g><title>Ingress 100%, 260B, Rows 100%, 3, Width 86B</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=\'22\' 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\'>260B</text>\n</g>\n<g><title>Ingress, Duration: 0.00 (0.00 | 0.00 | 0.00 - 0.00 | 0.00 | 0.00)</title><rect x=\'600\' 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 260B, Rows 3, Width 86B, Avg 260B/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\'>260B</text>\n</g>\n<g><title>CPU Usage 479us, 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\'>479us</text>\n</g>\n<g><title>Memory 202.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\'>202.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.41</title>\n<polygon points=\'598,26 598,26 598,26 598,26 598,26 598,26 598,26 598,26 598,26 599,26 599,26 599,26 600,26 600,26 600,26 600,26 600,26 600,26 600,13 601,24 601,26 601,26 601,26 602,26 602,26 602,26 602,26 602,26 602,26 602,26 603,26 603,26 603,21 604,25 604,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 1.00MB</title>\n<polygon points=\'598,42 598,29 604,29 604,42 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 0.23</title>\n<polygon points=\'598,58 598,58 598,58 598,58 598,58 598,58 598,58 598,58 598,58 599,58 599,58 599,58 600,58 600,58 600,58 600,58 600,58 600,58 600,58 601,58 601,58 601,58 601,58 602,58 602,58 602,58 602,58 602,58 602,58 602,58 603,58 603,58 603,45 604,58 604,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: h5616066189875708492_test_timestamp_unix_time_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\'>h5616066189875708492_test_timestamp_unix_time_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,111 601,98 601,111 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 0.74</title>\n<polygon points=\'598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 598,127 599,127 599,127 599,127 599,127 599,127 599,127 599,127 600,127 600,127 600,127 600,127 600,127 600,127 600,127 600,127 600,127 600,127 600,127 600,114 601,125 601,127 \' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n\n</svg>\n"
  }
}

2025-12-12 13:27:31,482 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f3738f31010>
2025-12-12 13:27:31,486 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f373903cd10>
2025-12-12 13:27:31,488 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f3737981610>
2025-12-12 13:27:31,488 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f373903ca10>
2025-12-12 13:27:31,495 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-12-12 13:27:31,504 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-12-12 13:27:31,505 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-12-12 13:27:31,506 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-12-12 13:27:31,508 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-12-12 13:27:31,508 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-12-12 13:27:31,510 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7f3737982090>
2025-12-12 13:27:31,510 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-12-12 13:27:31,511 - 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:27:31,511 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:31,511 - 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:27:31,512 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,512 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:31,512 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:31,512 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,513 - 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:27:31,514 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:31,514 - 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:27:31,515 - 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:27:31,516 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:31,516 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:31,516 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:31,516 - 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 0x7f371b94d1e0>, '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:27:31,517 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371b94fd50>>
2025-12-12 13:27:31,518 - 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 0x7f371ace1a00>>
2025-12-12 13:27:31,518 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:31,518 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:31,519 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:31,519 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:24309
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251212T132731Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:27:31,520 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132731Z
20251212/yandex/s3/aws4_request
46e6c3c7555012caa03932177e420b985a9a3aab7d4db7c37d9f0aaaa8048502
2025-12-12 13:27:31,520 - DEBUG - botocore.auth - add_auth: Signature:
a39aa1d1939397059f51dfc517607a458406023d226c17f0a63120a7b6b32c70
2025-12-12 13:27:31,520 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:31,520 - 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'20251212T132731Z', '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=a39aa1d1939397059f51dfc517607a458406023d226c17f0a63120a7b6b32c70', 'amz-sdk-invocation-id': b'a9701d3c-fc86-49bf-8d16-79019c922882', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:27:31,527 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:31 GMT', 'x-amzn-requestid': 'X40joT8KqpyhYqLfcXTHd2Yxm0roL109IgJfyfb4tVm4cyQizXfr', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '983', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:31,527 - 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>timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json</Key><LastModified>2025-12-12T13:27:30.000Z</LastModified><ETag>&#34;b10bb787896432ab6db06e920ce1f1bf&#34;</ETag><Size>185</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>timestamp/unix_time/test.json</Key><LastModified>2025-12-12T13:27:29.000Z</LastModified><ETag>&#34;56ede7cef02efaa4d249186b9f224769&#34;</ETag><Size>260</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-12-12 13:27:31,530 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f3737ba6a90>
2025-12-12 13:27:31,530 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:31,530 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,531 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7f3738f58890>
2025-12-12 13:27:31,531 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-12-12 13:27:31,532 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-12-12 13:27:31,533 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7f3737982210>
2025-12-12 13:27:31,534 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:27:31,535 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371b271910>}) about to wait for the following futures []
2025-12-12 13:27:31,539 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371b271910>}) done waiting for dependent futures
2025-12-12 13:27:31,539 - DEBUG - s3transfer.tasks - _execute_main: Executing task DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371b271910>}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b21e220>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7f371b1879e0>, 'osutil': <s3transfer.utils.OSUtils object at 0x7f371b186b80>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7f371b2713c0>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f371b271910>, 'io_executor': <s3transfer.futures.BoundedExecutor object at 0x7f371b186540>}
2025-12-12 13:27:31,540 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:27:31,541 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:31,541 - 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:27:31,541 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,541 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:31,542 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:31,542 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,542 - 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:27:31,544 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:31,544 - 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:27:31,544 - 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:27:31,546 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:31,546 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:31,546 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:31,547 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=HeadObject) with params: {'url_path': '/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', '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/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'url': 'http://localhost:24309/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f371b94d1e0>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:27:31,548 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:27:31,548 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371b94fd50>>
2025-12-12 13:27:31,549 - 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 0x7f371ace1a00>>
2025-12-12 13:27:31,549 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.HeadObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:31,550 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.HeadObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:31,550 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:31,550 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
HEAD
/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json

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

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:27:31,551 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132731Z
20251212/yandex/s3/aws4_request
75a9507e7a96fc80c18c674033819b4555ba621e309242ca0cffd1119a635fe4
2025-12-12 13:27:31,551 - DEBUG - botocore.auth - add_auth: Signature:
1d6d049abf142ee0fb2585f596526f765b14b63df13010d7f63a8cc9e20c4806
2025-12-12 13:27:31,552 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:27:31,552 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:31,552 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=HEAD, url=http://localhost:24309/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json, 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'20251212T132731Z', '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=1d6d049abf142ee0fb2585f596526f765b14b63df13010d7f63a8cc9e20c4806', 'amz-sdk-invocation-id': b'8eeee083-cbb3-4062-ae34-01226fcd6886', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:27:31,560 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:31 GMT', 'content-type': 'binary/octet-stream', 'ETag': '"b10bb787896432ab6db06e920ce1f1bf"', 'last-modified': 'Fri, 12 Dec 2025 13:27:30 GMT', 'Content-Length': '185', 'x-amzn-requestid': 'j8imcLo7hynossxhoQHMB6U4i7iF0aABCUhog2uhYSQeeUFalUam', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:31,560 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-12-12 13:27:31,562 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f3737ba6a90>
2025-12-12 13:27:31,562 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:31,562 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,563 - DEBUG - s3transfer.futures - submit: Submitting task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7f371b2713c0> for transfer request: 0.
2025-12-12 13:27:31,563 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-12-12 13:27:31,564 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'extra_args': {}}) about to wait for the following futures []
2025-12-12 13:27:31,564 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:27:31,571 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'extra_args': {}}) done waiting for dependent futures
2025-12-12 13:27:31,575 - DEBUG - s3transfer.tasks - _execute_main: Executing task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7f371b21e220>, 'bucket': 'fbucket', 'key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'fileobj': <_io.BytesIO object at 0x7f371b895160>, 'extra_args': {}, 'callbacks': [], 'max_attempts': 5, 'download_output_manager': <s3transfer.download.DownloadSeekableOutputManager object at 0x7f371b59bc60>, 'io_chunksize': 262144, 'bandwidth_limiter': None}
2025-12-12 13:27:31,576 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function sse_md5 at 0x7f3738f32f90>
2025-12-12 13:27:31,576 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function validate_bucket_name at 0x7f3738f32ed0>
2025-12-12 13:27:31,576 - 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:27:31,577 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,577 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function generate_idempotent_uuid at 0x7f3738f32c90>
2025-12-12 13:27:31,577 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f3738f599d0>
2025-12-12 13:27:31,578 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,578 - 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:27:31,578 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:24309/fbucket
2025-12-12 13:27:31,578 - 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:27:31,578 - 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:27:31,579 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_expect_header at 0x7f3738f33350>
2025-12-12 13:27:31,579 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_recursion_detection_header at 0x7f3738f31250>
2025-12-12 13:27:31,580 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function inject_api_version_header_if_needed at 0x7f3738f58dd0>
2025-12-12 13:27:31,580 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=GetObject) with params: {'url_path': '/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', '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/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'url': 'http://localhost:24309/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f371b94d1e0>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-12-12 13:27:31,581 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_not_transferring at 0x7f3738219790>
2025-12-12 13:27:31,582 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f371b94fd50>>
2025-12-12 13:27:31,582 - 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 0x7f371ace1a00>>
2025-12-12 13:27:31,582 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.GetObject: calling handler <function set_operation_specific_signer at 0x7f3738f32b10>
2025-12-12 13:27:31,583 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.GetObject: calling handler <function remove_arn_from_signing_path at 0x7f3738f59910>
2025-12-12 13:27:31,591 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-12-12 13:27:31,592 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json

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

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-12-12 13:27:31,592 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251212T132731Z
20251212/yandex/s3/aws4_request
33d3da88c0500ca2699e275f0a39210a864b3036e72cdc9ce326ab42b3616830
2025-12-12 13:27:31,592 - DEBUG - botocore.auth - add_auth: Signature:
22f7ef0dca901804a54014864ca58be65b6159294440366338526c2d18dc7af4
2025-12-12 13:27:31,593 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_transferring at 0x7f3738219850>
2025-12-12 13:27:31,593 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function add_retry_headers at 0x7f3738f596d0>
2025-12-12 13:27:31,593 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=True, method=GET, url=http://localhost:24309/fbucket/timestamp/unix_time/json_each_row/ptjudq7r3dpknrkbcqud_0_CTb654kWikuwu1KLY11MuRJcej_90xu5.json, 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'20251212T132731Z', '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=22f7ef0dca901804a54014864ca58be65b6159294440366338526c2d18dc7af4', 'amz-sdk-invocation-id': b'35f70750-8c1d-4b29-916f-81d5d4b114e3', 'amz-sdk-request': b'attempt=1'}>
2025-12-12 13:27:31,599 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 12 Dec 2025 13:27:31 GMT', 'x-amz-version-id': 'null', 'content-type': 'binary/octet-stream', 'ETag': '"b10bb787896432ab6db06e920ce1f1bf"', 'last-modified': 'Fri, 12 Dec 2025 13:27:30 GMT', 'Content-Length': '185', 'x-amzn-requestid': '4hAKfcT8UrLV9uUhD69zLaMIs316wfA2DhVHytMEItrx1gybOBxK', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-12-12 13:27:31,600 - DEBUG - botocore.parsers - parse: Response body:
<botocore.response.StreamingBody object at 0x7f3737c087d0>
2025-12-12 13:27:31,601 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f3737ba6a90>
2025-12-12 13:27:31,602 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-12-12 13:27:31,602 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f371b256180>>
2025-12-12 13:27:31,602 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) about to wait for the following futures []
2025-12-12 13:27:31,603 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) done waiting for dependent futures
2025-12-12 13:27:31,607 - DEBUG - s3transfer.tasks - _execute_main: Executing task IOWriteTask(transfer_id=0, {'offset': 0}) with kwargs {'fileobj': <_io.BytesIO object at 0x7f371b895160>, 'offset': 0}
2025-12-12 13:27:31,607 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) about to wait for the following futures []
2025-12-12 13:27:31,608 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) done waiting for dependent futures
2025-12-12 13:27:31,608 - DEBUG - s3transfer.tasks - _execute_main: Executing task CompleteDownloadNOOPTask(transfer_id=0, {}) with kwargs {}
2025-12-12 13:27:31,608 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-12-12 13:27:31,619 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-12-12 13:31:28,433 - DEBUG - ya.test - _verify_test: Verifying [test_format_setting.TestS3.test_timestamp_unix_time_insert[v2-timestamp/unix_time/test.json-json_each_row-UNIX_TIME_MICROSECONDS] in ydb/tests/fq/s3] canonical results
2025-12-12 13:31:28,435 - DEBUG - ya.test - verify: Test test_format_setting.TestS3.test_timestamp_unix_time_insert[v2-timestamp/unix_time/test.json-json_each_row-UNIX_TIME_MICROSECONDS] status: good
