2025-11-14 10:13:19,515 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-14 10:13:19,515 - INFO - ya.test - pytest_runtest_setup: test_timestamp_simple_format_insert[v2-common/simple_format/test.json-json_each_row]
2025-11-14 10:13:19,522 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-14 10:13:19,523 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-14 10:13:19,733 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_format_setting.py::TestS3, test_name: test_timestamp_simple_format_insert[v2-common/simple_format/test.json-json_each_row])
2025-11-14 10:13:19,735 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7facac218dd0>
2025-11-14 10:13:19,740 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7facac324ad0>
2025-11-14 10:13:19,740 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7facaab71250>
2025-11-14 10:13:19,740 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7facac3247d0>
2025-11-14 10:13:19,745 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-11-14 10:13:19,760 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-11-14 10:13:19,763 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-11-14 10:13:19,765 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-11-14 10:13:19,767 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-11-14 10:13:19,771 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-11-14 10:13:19,781 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7facaab71cd0>
2025-11-14 10:13:19,787 - DEBUG - boto3.resources.action - __call__: Calling s3:create_bucket with {'Bucket': 'fbucket', 'ACL': 'public-read'}
2025-11-14 10:13:19,788 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:19,788 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:19,789 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,789 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:19,792 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:19,793 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,795 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableAccessPoints': True, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:19,797 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:19,797 - 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-11-14 10:13:19,798 - 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-11-14 10:13:19,805 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:19,805 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:19,817 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:19,817 - 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:20364/fbucket', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8dead230>, '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-11-14 10:13:19,818 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8dead1e0>>
2025-11-14 10:13:19,824 - 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 0x7fac8e405a50>>
2025-11-14 10:13:19,825 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.CreateBucket: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:19,828 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.CreateBucket: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:19,829 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:19,829 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket

host:localhost:20364
x-amz-acl:public-read
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251114T101319Z

host;x-amz-acl;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-14 10:13:19,829 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101319Z
20251114/yandex/s3/aws4_request
f451c31d068c588129c513cc4819bccb95134d817a6244505ed45da72e70d619
2025-11-14 10:13:19,829 - DEBUG - botocore.auth - add_auth: Signature:
807b06d6495b38941395091ebf4dfb513c3cdd04b05b4872646d0405820b51d1
2025-11-14 10:13:19,830 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:19,830 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:20364/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'20251114T101319Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=host;x-amz-acl;x-amz-content-sha256;x-amz-date, Signature=807b06d6495b38941395091ebf4dfb513c3cdd04b05b4872646d0405820b51d1', 'amz-sdk-invocation-id': b'9175109d-3495-435e-ba0e-ba87062d9f5c', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2025-11-14 10:13:19,847 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:19 GMT', 'x-amzn-requestid': 'wG5ceVpAle4QOZLblYVIni2Rag48lnofcZ8Fu1vVVCkqq8c2NWeh', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '161', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:19,848 - DEBUG - botocore.parsers - parse: Response body:
b'<CreateBucketResponse xmlns="http://s3.amazonaws.com/doc/2006-03-01"><CreateBucketResponse><Bucket>fbucket</Bucket></CreateBucketResponse></CreateBucketResponse>'
2025-11-14 10:13:19,849 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8e4b3b20>
2025-11-14 10:13:19,849 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:19,850 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,851 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'wG5ceVpAle4QOZLblYVIni2Rag48lnofcZ8Fu1vVVCkqq8c2NWeh', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 14 Nov 2025 10:13:19 GMT', 'x-amzn-requestid': 'wG5ceVpAle4QOZLblYVIni2Rag48lnofcZ8Fu1vVVCkqq8c2NWeh', 'content-type': 'text/html; charset=utf-8', 'content-length': '161', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}}
2025-11-14 10:13:19,851 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-11-14 10:13:19,853 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function set_list_objects_encoding_type_url at 0x7facac23c590>
2025-11-14 10:13:19,853 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:19,854 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:19,859 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,859 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:19,868 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:19,869 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,874 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:19,876 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:19,879 - 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-11-14 10:13:19,884 - 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-11-14 10:13:19,886 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:19,886 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:19,887 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:19,888 - 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:20364/fbucket?encoding-type=url', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8dead230>, '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-11-14 10:13:19,890 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8dead1e0>>
2025-11-14 10:13:19,890 - 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 0x7fac8e405a50>>
2025-11-14 10:13:19,907 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:19,908 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:19,916 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:19,920 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:20364
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251114T101319Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-14 10:13:19,921 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101319Z
20251114/yandex/s3/aws4_request
c4e1998c83366146f6538f759518a55a9e4bc228ef6096a8e66c08f392fdcb13
2025-11-14 10:13:19,921 - DEBUG - botocore.auth - add_auth: Signature:
a35e002f5c6cab540539f3486d6da5ef626a42457ed6b5c265379a37f2f01a70
2025-11-14 10:13:19,922 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:19,934 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=GET, url=http://localhost:20364/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'20251114T101319Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=a35e002f5c6cab540539f3486d6da5ef626a42457ed6b5c265379a37f2f01a70', 'amz-sdk-invocation-id': b'9dd2f94d-6984-4ffc-bea4-388e8666bbeb', 'amz-sdk-request': b'attempt=1'}>
2025-11-14 10:13:19,944 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:19 GMT', 'x-amzn-requestid': 'ydPGZsXXahU87CK4ZB2D9t7ZH6DQKoYpNq0FYrDJ2yJDhhCkdlsl', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '982', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:19,944 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>fbucket</Name><MaxKeys>1000</MaxKeys><EncodingType>url</EncodingType><IsTruncated>false</IsTruncated><Contents><Key>common/simple_format/test.tsv</Key><LastModified>2025-11-14T10:13:17.000Z</LastModified><ETag>&#34;5dfe23d100f998bdec629d1974ff770d&#34;</ETag><Size>70</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv</Key><LastModified>2025-11-14T10:13:18.000Z</LastModified><ETag>&#34;67db5f2090a0a3cf03a868ea174eadd9&#34;</ETag><Size>70</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-11-14 10:13:19,947 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8e4b3b20>
2025-11-14 10:13:19,947 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:19,947 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,948 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7facac23c650>
2025-11-14 10:13:19,948 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-11-14 10:13:19,948 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-11-14 10:13:19,950 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7facaab71e50>
2025-11-14 10:13:19,951 - DEBUG - boto3.resources.action - __call__: Calling s3:delete_objects with {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_format/test.tsv'}, {'Key': 'common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv'}]}}
2025-11-14 10:13:19,952 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:19,952 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:19,952 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,952 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:19,953 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:19,953 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:19,956 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:19,956 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:19,961 - 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-11-14 10:13:19,962 - 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-11-14 10:13:19,988 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function escape_xml_payload at 0x7facac21a690>
2025-11-14 10:13:19,988 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:19,990 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:19,990 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:19,991 - 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': 'eZfVn76l7MxK8tEqgUz+cA=='}, 'body': b'<Delete xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Object><Key>common/simple_format/test.tsv</Key></Object><Object><Key>common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv</Key></Object></Delete>', 'auth_path': '/fbucket/', 'url': 'http://localhost:20364/fbucket?delete', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8dead230>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_format/test.tsv'}, {'Key': 'common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv'}]}}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'checksum': {'request_algorithm': 'conditional-md5'}}}
2025-11-14 10:13:19,993 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8dead1e0>>
2025-11-14 10:13:19,995 - 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 0x7fac8e405a50>>
2025-11-14 10:13:19,996 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.DeleteObjects: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:19,998 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.DeleteObjects: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:20,021 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:20,022 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
POST
/fbucket
delete=
content-md5:eZfVn76l7MxK8tEqgUz+cA==
host:localhost:20364
x-amz-content-sha256:08dc621e429b160ba8c847899ffbdf1d717793b4982d0e12982c211a6f9b8487
x-amz-date:20251114T101320Z

content-md5;host;x-amz-content-sha256;x-amz-date
08dc621e429b160ba8c847899ffbdf1d717793b4982d0e12982c211a6f9b8487
2025-11-14 10:13:20,023 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101320Z
20251114/yandex/s3/aws4_request
581c4c44f436261437031b0553e04a5b13cf98969d6e39dea8cc4dbfa271929a
2025-11-14 10:13:20,024 - DEBUG - botocore.auth - add_auth: Signature:
1c194bd1f91c3ebec2cc5f02dc0d36074c993dbbcdf7aecc0cf202afbe137342
2025-11-14 10:13:20,026 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:20,034 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=POST, url=http://localhost:20364/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'eZfVn76l7MxK8tEqgUz+cA==', 'X-Amz-Date': b'20251114T101320Z', 'X-Amz-Content-SHA256': b'08dc621e429b160ba8c847899ffbdf1d717793b4982d0e12982c211a6f9b8487', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=1c194bd1f91c3ebec2cc5f02dc0d36074c993dbbcdf7aecc0cf202afbe137342', 'amz-sdk-invocation-id': b'eb8ec4d9-8f74-4817-bd90-14d507ce5fff', 'amz-sdk-request': b'attempt=1', 'Content-Length': '245'}>
2025-11-14 10:13:20,044 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:20 GMT', 'x-amzn-requestid': 'jYMlDTSs5Xdjmfc3tpdMyyrPoCBpxq5BRa0nmhROunCk6sWakh8s', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '298', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:20,045 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><DeleteResult xmlns="http://s3.amazonaws.com/doc/2006-03-01"><Deleted><Key>common/simple_format/test.tsv</Key></Deleted><Deleted><Key>common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv</Key></Deleted></DeleteResult>'
2025-11-14 10:13:20,045 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8e4b3b20>
2025-11-14 10:13:20,046 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:20,046 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7facab2de220>>
2025-11-14 10:13:20,046 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'jYMlDTSs5Xdjmfc3tpdMyyrPoCBpxq5BRa0nmhROunCk6sWakh8s', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.9', 'date': 'Fri, 14 Nov 2025 10:13:20 GMT', 'x-amzn-requestid': 'jYMlDTSs5Xdjmfc3tpdMyyrPoCBpxq5BRa0nmhROunCk6sWakh8s', 'content-type': 'text/html; charset=utf-8', 'content-length': '298', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}, 'Deleted': [{'Key': 'common/simple_format/test.tsv'}, {'Key': 'common/simple_format/tsv_with_names/ptjudsej0ej9u1til8tn_0_ByhTP5pmaUOYSYcKdp7UP56woggu2UU8.tsv'}]}
2025-11-14 10:13:20,047 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7facac218dd0>
2025-11-14 10:13:20,050 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7facac324ad0>
2025-11-14 10:13:20,058 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7facaab71250>
2025-11-14 10:13:20,059 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7facac3247d0>
2025-11-14 10:13:20,063 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-11-14 10:13:20,071 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-11-14 10:13:20,072 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-11-14 10:13:20,074 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-14 10:13:20,075 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8da6b850>}) about to wait for the following futures []
2025-11-14 10:13:20,079 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8da6b850>}) done waiting for dependent futures
2025-11-14 10:13:20,081 - DEBUG - s3transfer.tasks - _execute_main: Executing task UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8da6b850>}) with kwargs {'client': <botocore.client.S3 object at 0x7fac8d528b50>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7facaafc4ba0>, 'osutil': <s3transfer.utils.OSUtils object at 0x7fac8da6a400>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7fac8da6ad60>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8da6b850>}
2025-11-14 10:13:20,081 - DEBUG - s3transfer.futures - submit: Submitting task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.json', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7fac8da6ad60> for transfer request: 0.
2025-11-14 10:13:20,082 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-14 10:13:20,083 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.json', 'extra_args': {}}) about to wait for the following futures []
2025-11-14 10:13:20,083 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-14 10:13:20,085 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.json', 'extra_args': {}}) done waiting for dependent futures
2025-11-14 10:13:20,087 - DEBUG - s3transfer.tasks - _execute_main: Executing task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/test.json', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7fac8d528b50>, 'fileobj': <s3transfer.utils.ReadFileChunk object at 0x7fac8da78e20>, 'bucket': 'fbucket', 'key': 'common/simple_format/test.json', 'extra_args': {}}
2025-11-14 10:13:20,089 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_ascii_metadata at 0x7facac21bd10>
2025-11-14 10:13:20,089 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function sse_md5 at 0x7facac21ad50>
2025-11-14 10:13:20,089 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function convert_body_to_file_like_object at 0x7facac23ca10>
2025-11-14 10:13:20,090 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:20,090 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:20,090 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d413760>>
2025-11-14 10:13:20,090 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:20,091 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:20,094 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d413760>>
2025-11-14 10:13:20,095 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:20,097 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:20,099 - 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-11-14 10:13:20,099 - 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-11-14 10:13:20,100 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function conditionally_calculate_md5 at 0x7facac42fc50>
2025-11-14 10:13:20,102 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:20,102 - DEBUG - botocore.handlers - add_expect_header: Adding expect 100 continue header to request.
2025-11-14 10:13:20,107 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:20,107 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:20,107 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=PutObject) with params: {'url_path': '/common/simple_format/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': 'WjOpzKzOnkp/4X+Ut17gcg==', 'Expect': '100-continue'}, 'body': <s3transfer.utils.ReadFileChunk object at 0x7fac8da78e20>, 'auth_path': '/fbucket/common/simple_format/test.json', 'url': 'http://localhost:20364/fbucket/common/simple_format/test.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8dad2d10>, 'has_streaming_input': True, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/test.json', 'Body': <s3transfer.utils.ReadFileChunk object at 0x7fac8da78e20>}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-11-14 10:13:20,109 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_not_transferring at 0x7facab1e13d0>
2025-11-14 10:13:20,110 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8dad2360>>
2025-11-14 10:13:20,113 - 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 0x7fac8db06c20>>
2025-11-14 10:13:20,114 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.PutObject: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:20,114 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.PutObject: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:20,115 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:20,115 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket/common/simple_format/test.json

content-md5:WjOpzKzOnkp/4X+Ut17gcg==
host:localhost:20364
x-amz-content-sha256:270909b8e898ef13499538fdfcdcf9605247e9c410f0375e6748f4b01bfdd4c6
x-amz-date:20251114T101320Z

content-md5;host;x-amz-content-sha256;x-amz-date
270909b8e898ef13499538fdfcdcf9605247e9c410f0375e6748f4b01bfdd4c6
2025-11-14 10:13:20,116 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101320Z
20251114/yandex/s3/aws4_request
2d1f2e3df221277bf3ca6e2b63e0e4123b39acba16afadef2fafe9f3f2ee9c6d
2025-11-14 10:13:20,117 - DEBUG - botocore.auth - add_auth: Signature:
e020b06972e9a0cf76c57e623fb9b9eefd39614443c92d65b69278bef6adf79c
2025-11-14 10:13:20,118 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_transferring at 0x7facab1e1490>
2025-11-14 10:13:20,119 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:20,120 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:20364/fbucket/common/simple_format/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'WjOpzKzOnkp/4X+Ut17gcg==', 'Expect': b'100-continue', 'X-Amz-Date': b'20251114T101320Z', 'X-Amz-Content-SHA256': b'270909b8e898ef13499538fdfcdcf9605247e9c410f0375e6748f4b01bfdd4c6', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=e020b06972e9a0cf76c57e623fb9b9eefd39614443c92d65b69278bef6adf79c', 'amz-sdk-invocation-id': b'65eb8ef9-62a1-4527-8c63-3c611a1b8c4f', 'amz-sdk-request': b'attempt=1', 'Content-Length': '185'}>
2025-11-14 10:13:20,123 - DEBUG - botocore.awsrequest - _send_output: Waiting for 100 Continue response.
2025-11-14 10:13:20,124 - DEBUG - botocore.awsrequest - _handle_expect_response: 100 Continue response seen, now sending request body.
2025-11-14 10:13:20,129 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:20 GMT', 'ETag': '"5a33a9ccacce9e4a7fe17f94b75ee072"', 'last-modified': 'Fri, 14 Nov 2025 10:13:20 GMT', 'Content-Length': '0', 'x-amzn-requestid': 'vlENQlNIZeEkfIKGAV020oTD71KUd599tsWbhImxGFK3pTC0buL6', 'Content-Type': 'text/html; charset=utf-8', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:20,129 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-11-14 10:13:20,132 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8da68dd0>
2025-11-14 10:13:20,132 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:20,132 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d413760>>
2025-11-14 10:13:20,133 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-14 10:13:20,134 - DEBUG - root - wait_bootstrap: Wait for node 1 to bootstrap
2025-11-14 10:13:20,187 - DEBUG - root - wait_bootstrap: Node 1 has been bootstrapped
2025-11-14 10:13:20,384 - DEBUG - root - create_query_impl: Request: content {
  type: ANALYTICS
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO bindings.`h6309420410484035864_test_timestamp_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h6309420410484035864_test_timestamp_simple_format_insertmy_binding`\n            "
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "547575a3-2493-49f0-821a-ee9ff5563fbc"

2025-11-14 10:13:20,415 - DEBUG - root - create_query_impl: Result: query_id: "ptqudsej0cgnb1p1o70q"

2025-11-14 10:13:20,429 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudsej0cgnb1p1o70q"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1763115200
        nanos: 389780000
      }
      modified_at {
        seconds: 1763115200
        nanos: 389780000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudsej0cgn96m9v3hp-ptqudsej0cgnb1p1o70q"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1763115200
      nanos: 389780000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h6309420410484035864_test_timestamp_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h6309420410484035864_test_timestamp_simple_format_insertmy_binding`\n            "
    syntax: YQL_V1
  }
}

2025-11-14 10:13:20,954 - DEBUG - root - describe_query: Result: ... (repeated, see above) ...
2025-11-14 10:13:21,473 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudsej0cgnb1p1o70q"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1763115200
        nanos: 389780000
      }
      modified_at {
        seconds: 1763115200
        nanos: 389780000
      }
      revision: 1
    }
    started_at {
      seconds: 1763115201
      nanos: 345000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudsej0cgn96m9v3hp-ptqudsej0cgnb1p1o70q"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1763115200
      nanos: 389780000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h6309420410484035864_test_timestamp_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h6309420410484035864_test_timestamp_simple_format_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-11-14 10:13:21,987 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudsej0cgnb1p1o70q"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1763115200
        nanos: 389780000
      }
      modified_at {
        seconds: 1763115200
        nanos: 389780000
      }
      revision: 1
    }
    started_at {
      seconds: 1763115201
      nanos: 345000000
    }
    finished_at {
      seconds: 1763115201
      nanos: 524000000
    }
    execute_mode: RUN
    status: COMPLETED
    last_job_query_revision: 1
    last_job_id: "ptjudsej0cgn96m9v3hp-ptqudsej0cgnb1p1o70q"
    result_expire_at {
      seconds: 1763201601
      nanos: 321633000
    }
    started_by: "root@builtin"
    submitted_at {
      seconds: 1763115200
      nanos: 389780000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            INSERT INTO bindings.`h6309420410484035864_test_timestamp_simple_format_insertinsert_my_binding`\n            SELECT Unwrap(Time + Interval(\"P1D\")) as Time, Fruit, Price, Weight\n            FROM bindings.`h6309420410484035864_test_timestamp_simple_format_insertmy_binding`\n            "
    syntax: YQL_V1
  }
  plan {
    json: "{\"Plan\":{\"Plans\":[{\"PlanNodeId\":5,\"Plans\":[{\"PlanNodeId\":4,\"Plans\":[{\"PlanNodeId\":3,\"Plans\":[{\"PlanNodeId\":2,\"Plans\":[{\"PlanNodeId\":1,\"Operators\":[{\"E-Size\":\"34.25925926\",\"Format\":\"json_each_row\",\"Name\":\"h6309420410484035864_test_timestamp_simple_format_insertmy_binding\",\"Inputs\":[],\"Path\":\"common/simple_format/test.json \",\"E-Rows\":\"0.7786195286\",\"ExternalDataSource\":\"h6309420410484035864_test_timestamp_simple_format_insertfruitbucket\",\"ReadColumns\":[\"Fruit\",\"Price\",\"Time\",\"Weight\"],\"SourceType\":\"s3\",\"E-Cost\":\"185\"}],\"Node Type\":\"Source\"}],\"Node Type\":\"Stage\"}],\"Node Type\":\"Map\",\"PlanNodeType\":\"Connection\"}],\"Node Type\":\"Stage\"}],\"Operators\":[{\"Inputs\":[],\"ExternalDataSource\":\"h6309420410484035864_test_timestamp_simple_format_insertfruitbucket\",\"Extension\":\".json\",\"Name\":\"Write h6309420410484035864_test_timestamp_simple_format_insertfruitbucket\",\"SinkType\":\"s3\"}],\"Node Type\":\"Sink\"}],\"Node Type\":\"Query\",\"PlanNodeType\":\"Query\"},\"meta\":{\"version\":\"0.2\",\"type\":\"query\"}}"
  }
  statistics {
    json: "{\"Sink\":{\"Tasks\":{\"sum\":2,\"count\":2,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"574us\",\"count\":2,\"avg\":\"287us\",\"max\":\"321us\",\"min\":\"253us\"},\"IngressBytes\":{\"sum\":185,\"count\":1,\"avg\":185,\"max\":185,\"min\":185},\"IngressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"InputBytes\":{\"sum\":41,\"count\":1,\"avg\":41,\"max\":41,\"min\":41},\"InputRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"OutputBytes\":{\"sum\":41,\"count\":1,\"avg\":41,\"max\":41,\"min\":41},\"OutputRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"EgressBytes\":{\"sum\":122,\"count\":1,\"avg\":122,\"max\":122,\"min\":122},\"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/h6309420410484035864_test_timestamp_simple_format_insertfruitbucket\")\n(let $2 \'\"/local/h6309420410484035864_test_timestamp_simple_format_insertmy_binding\")\n(let $3 (DataSource \'\"s3\" $1 $2))\n(let $4 \'\"Paths {\\n  Name: \\\"common\\\"\\n  Children {\\n    Name: \\\"simple_format\\\"\\n    Children {\\n      Name: \\\"test.json\\\"\\n      Size: 185\\n      Read: true\\n    }\\n    IsDirectory: true\\n  }\\n  IsDirectory: true\\n}\\n\")\n(let $5 (Bool \'\"true\"))\n(let $6 \'\"cluster:default_/local/h6309420410484035864_test_timestamp_simple_format_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.format\" \'\"%Y-%m-%d\"))\n(let $11 (S3ParseSettings world \'(\'((String $4) $5 (AsStruct))) $7 \'\"\" \'\"common/simple_format/test.json \" \'\"json_each_row\" $9 (lambda \'($17) $5) \'($10)))\n(let $12 \'(\'(\'\"_logical_id\" \'579) \'(\'\"_id\" \'\"d18560ed-1da1084a-8471b806-765f3b91\") \'(\'\"_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 \'\"common/simple_format/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\" \'\"cffe0734-cbdba791-51764767-ca42695e\")) \'((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%, 321us</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\'>321us</text>\n</g>\n<g><title>Input 100%, 41B, Rows 100%, 2, Width 20B</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\'>41B</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=\'602\' y=\'61\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--input-medium, #5A8183)\'/>\n</g>\n<rect x=\'0\' y=\'80\' width=\'298\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'301\' y=\'80\' width=\'64\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'395\' y=\'80\' width=\'200\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'368\' y=\'80\' width=\'24\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<rect x=\'598\' y=\'80\' width=\'682\' height=\'66\' stroke-width=\'0\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<circle cx=\'8\' cy=\'113\' r=\'7\' stroke=\'var(--stage-main, #F2F2F2)\' stroke-width=\'1\' fill=\'var(--stage-clone, #D9D9D9)\' />\n<text text-anchor=\'middle\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'8\' y=\'117\'>0</text>\n<g><title>Output Rows 50%, 2</title>\n  <rect x=\'303\' y=\'86\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,86 333,86 363,86 363,100 303,100\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'89\' width=\'5\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'303\' y=\'97\'>2</text>\n</g>\n<g><title>Output Rows 50%, 2, Est: 185 Rows: 0 Size: 34B</title>\n  <rect x=\'303\' y=\'106\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,106 333,106 363,106 363,120 303,120\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'109\' width=\'5\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'303\' y=\'117\'>2</text>\n</g>\n<g><title>Output 100%, 41B, Rows 100%, 2</title>\n<use href=\'#icon_output\' transform=\'translate(395 82) scale(0.9 0.9)\' fill=\'var(--output-medium, #5781B9)\'/>\n  <rect x=\'413\' y=\'82\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'413,82 503,82 593,82 593,96 413,96\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'413\' y=\'85\' width=\'16\' height=\'9\' stroke-width=\'0\' opacity=\'0.5\' fill=\'var(--stage-main, #F2F2F2)\'/>\n<text font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--text-summary, #262626)\' x=\'413\' y=\'93\'>41B</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=\'602\' 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%, 253us</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=\'141\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,114 483,114 554,114 554,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\'>253us</text>\n</g>\n<g><title>Ingress 100%, 185B, Rows 100%, 2, Width 92B</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\'>185B</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=\'602\' 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 185B, Rows 2, Width 92B, Avg 185B/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\'>185B</text>\n</g>\n<g><title>CPU Usage 574us, 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\'>574us</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.46</title>\n<polygon points=\'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 601,26 601,26 601,13 602,25 602,26 602,26 602,26 602,26 602,26 603,26 603,26 603,26 604,26 604,26 604,26 604,26 604,22 605,26 605,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 605,29 605,42 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 0.19</title>\n<polygon points=\'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 601,58 601,58 601,58 602,58 602,58 602,58 602,58 602,58 602,58 603,58 603,58 603,58 604,58 604,58 604,58 604,58 604,45 605,58 605,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: h6309420410484035864_test_timestamp_simple_format_insertmy_binding(Fruit, Price, Time, Weight)</title>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'18\' y=\'111\'>Source s3</text>  <text clip-path=\'url(#clipTextPath)\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'22\' y=\'121\'>h6309420410484035864_test_timestamp_simple_format_insertmy_binding(Fruit, Price, Time, Weight)</text></g>\n<g><title>Stage 0, tasks: 1, finished: 1</title>\n<line x1=\'371\' y1=\'80\' x2=\'371\' y2=\'146\' stroke-width=\'6\' stroke=\'var(--stage-text, #262626)\' stroke-dasharray=\'1,1\' />\n  <text text-anchor=\'end\' font-family=\'Verdana\' font-size=\'8px\' fill=\'var(--stage-text, #262626)\' x=\'390\' y=\'117\'>1</text>\n</g>\n<g><title>Max MEM 201.00MB</title>\n<polygon points=\'598,111 598,111 602,98 602,111 \' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>Max CPU 0.85</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 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 601,127 601,127 601,127 601,127 601,114 602,126 602,127 \' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n\n</svg>\n"
  }
}

2025-11-14 10:13:21,999 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7facac218dd0>
2025-11-14 10:13:22,007 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7facac324ad0>
2025-11-14 10:13:22,007 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7facaab71250>
2025-11-14 10:13:22,008 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7facac3247d0>
2025-11-14 10:13:22,011 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-11-14 10:13:22,015 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-11-14 10:13:22,019 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-11-14 10:13:22,020 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-11-14 10:13:22,022 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-11-14 10:13:22,023 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-11-14 10:13:22,028 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7facaab71cd0>
2025-11-14 10:13:22,029 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-11-14 10:13:22,031 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function set_list_objects_encoding_type_url at 0x7facac23c590>
2025-11-14 10:13:22,031 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:22,032 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:22,033 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,033 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:22,034 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:22,035 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,036 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:22,038 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:22,038 - 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-11-14 10:13:22,038 - 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-11-14 10:13:22,039 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:22,042 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:22,042 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:22,042 - 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:20364/fbucket?encoding-type=url', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8d733990>, '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-11-14 10:13:22,044 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8d7329a0>>
2025-11-14 10:13:22,059 - 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 0x7facab2df940>>
2025-11-14 10:13:22,060 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:22,063 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:22,068 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:22,068 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:20364
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251114T101322Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-14 10:13:22,069 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101322Z
20251114/yandex/s3/aws4_request
9b8ada8175fb2e905fbb248d72a706eb598d2432481cd23ae207af280a5eca3f
2025-11-14 10:13:22,069 - DEBUG - botocore.auth - add_auth: Signature:
17a9c128bf5d1ad2de7dbe78f388e9b6d567a3f908999d24c7ff5d71dd76c1d9
2025-11-14 10:13:22,070 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:22,072 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=GET, url=http://localhost:20364/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'20251114T101322Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=17a9c128bf5d1ad2de7dbe78f388e9b6d567a3f908999d24c7ff5d71dd76c1d9', 'amz-sdk-invocation-id': b'40db3116-fb53-42a0-920b-d5b00647df86', 'amz-sdk-request': b'attempt=1'}>
2025-11-14 10:13:22,081 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:22 GMT', 'x-amzn-requestid': 'eL9zbthmJ6qneJdd9vOxuBPVfqJAdem7ivgkb0zA6PVQSl9PANjf', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '985', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:22,082 - DEBUG - botocore.parsers - parse: Response body:
b'<?xml version="1.0" encoding="UTF-8"?><ListBucketResult xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Name>fbucket</Name><MaxKeys>1000</MaxKeys><EncodingType>url</EncodingType><IsTruncated>false</IsTruncated><Contents><Key>common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json</Key><LastModified>2025-11-14T10:13:21.000Z</LastModified><ETag>&#34;12d351f710dc1c1177b3b8e30a7ee5ab&#34;</ETag><Size>122</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents><Contents><Key>common/simple_format/test.json</Key><LastModified>2025-11-14T10:13:20.000Z</LastModified><ETag>&#34;5a33a9ccacce9e4a7fe17f94b75ee072&#34;</ETag><Size>185</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-11-14 10:13:22,084 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8d47e2c0>
2025-11-14 10:13:22,085 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:22,086 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,087 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7facac23c650>
2025-11-14 10:13:22,088 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-11-14 10:13:22,089 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-11-14 10:13:22,091 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7facaab71e50>
2025-11-14 10:13:22,093 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-14 10:13:22,093 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8d4ade60>}) about to wait for the following futures []
2025-11-14 10:13:22,094 - DEBUG - s3transfer.tasks - _wait_until_all_complete: DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8d4ade60>}) done waiting for dependent futures
2025-11-14 10:13:22,095 - DEBUG - s3transfer.tasks - _execute_main: Executing task DownloadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8d4ade60>}) with kwargs {'client': <botocore.client.S3 object at 0x7fac8da2ab80>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7fac8d4ad6e0>, 'osutil': <s3transfer.utils.OSUtils object at 0x7fac8d4adb40>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7fac8d4af1c0>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7fac8d4ade60>, 'io_executor': <s3transfer.futures.BoundedExecutor object at 0x7fac8d4ac830>}
2025-11-14 10:13:22,096 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function sse_md5 at 0x7facac21ad50>
2025-11-14 10:13:22,096 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:22,096 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:22,097 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,097 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.HeadObject: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:22,097 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:22,098 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,098 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:22,101 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:22,101 - 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-11-14 10:13:22,101 - 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-11-14 10:13:22,102 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:22,103 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:22,103 - DEBUG - botocore.hooks - _emit: Event before-call.s3.HeadObject: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:22,103 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=HeadObject) with params: {'url_path': '/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.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/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'url': 'http://localhost:20364/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8d733990>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-11-14 10:13:22,105 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_not_transferring at 0x7facab1e13d0>
2025-11-14 10:13:22,105 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8d7329a0>>
2025-11-14 10:13:22,105 - 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 0x7facab2df940>>
2025-11-14 10:13:22,106 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.HeadObject: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:22,106 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.HeadObject: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:22,108 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:22,108 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
HEAD
/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json

host:localhost:20364
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251114T101322Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-14 10:13:22,109 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101322Z
20251114/yandex/s3/aws4_request
54fd9679b079224fe564d3ee7377032cc6c21bf1ff6127f90004d4cb347fc4bc
2025-11-14 10:13:22,109 - DEBUG - botocore.auth - add_auth: Signature:
733136c82e2f7c63464048bf63976612c409dfd4187eb9947d477360eaf5fd59
2025-11-14 10:13:22,109 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function signal_transferring at 0x7facab1e1490>
2025-11-14 10:13:22,110 - DEBUG - botocore.hooks - _emit: Event request-created.s3.HeadObject: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:22,110 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=HEAD, url=http://localhost:20364/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.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'20251114T101322Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=733136c82e2f7c63464048bf63976612c409dfd4187eb9947d477360eaf5fd59', 'amz-sdk-invocation-id': b'df90dea1-4e44-4043-9ea9-7f39c0b30b36', 'amz-sdk-request': b'attempt=1'}>
2025-11-14 10:13:22,122 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:22 GMT', 'content-type': 'binary/octet-stream', 'ETag': '"12d351f710dc1c1177b3b8e30a7ee5ab"', 'last-modified': 'Fri, 14 Nov 2025 10:13:21 GMT', 'Content-Length': '122', 'x-amzn-requestid': 'M2GviQvpczGr9VlBIxfhvU1SU3NfCh1nJJrX72OLT3ZYIbnvWhYj', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:22,123 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-11-14 10:13:22,125 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8d47e2c0>
2025-11-14 10:13:22,126 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:22,126 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.HeadObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,127 - DEBUG - s3transfer.futures - submit: Submitting task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7fac8d4af1c0> for transfer request: 0.
2025-11-14 10:13:22,128 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-14 10:13:22,128 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'extra_args': {}}) about to wait for the following futures []
2025-11-14 10:13:22,129 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-14 10:13:22,129 - DEBUG - s3transfer.tasks - _wait_until_all_complete: ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'extra_args': {}}) done waiting for dependent futures
2025-11-14 10:13:22,130 - DEBUG - s3transfer.tasks - _execute_main: Executing task ImmediatelyWriteIOGetObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7fac8da2ab80>, 'bucket': 'fbucket', 'key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'fileobj': <_io.BytesIO object at 0x7fac8d242900>, 'extra_args': {}, 'callbacks': [], 'max_attempts': 5, 'download_output_manager': <s3transfer.download.DownloadSeekableOutputManager object at 0x7fac8da74790>, 'io_chunksize': 262144, 'bandwidth_limiter': None}
2025-11-14 10:13:22,131 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function sse_md5 at 0x7facac21ad50>
2025-11-14 10:13:22,131 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function validate_bucket_name at 0x7facac21ac90>
2025-11-14 10:13:22,131 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7facac23d550>
2025-11-14 10:13:22,131 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,132 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.GetObject: calling handler <function generate_idempotent_uuid at 0x7facac21aa50>
2025-11-14 10:13:22,133 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7facac23d790>
2025-11-14 10:13:22,134 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,136 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:20364', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-14 10:13:22,136 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:20364/fbucket
2025-11-14 10:13:22,137 - 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-11-14 10:13:22,138 - 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-11-14 10:13:22,139 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_expect_header at 0x7facac21b110>
2025-11-14 10:13:22,139 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function add_recursion_detection_header at 0x7facac219010>
2025-11-14 10:13:22,140 - DEBUG - botocore.hooks - _emit: Event before-call.s3.GetObject: calling handler <function inject_api_version_header_if_needed at 0x7facac23cb90>
2025-11-14 10:13:22,141 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=GetObject) with params: {'url_path': '/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.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/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'url': 'http://localhost:20364/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7fac8d733990>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json'}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}}}
2025-11-14 10:13:22,143 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_not_transferring at 0x7facab1e13d0>
2025-11-14 10:13:22,143 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7fac8d7329a0>>
2025-11-14 10:13:22,144 - 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 0x7facab2df940>>
2025-11-14 10:13:22,145 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.GetObject: calling handler <function set_operation_specific_signer at 0x7facac21a8d0>
2025-11-14 10:13:22,145 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.GetObject: calling handler <function remove_arn_from_signing_path at 0x7facac23d6d0>
2025-11-14 10:13:22,147 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-14 10:13:22,148 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.json

host:localhost:20364
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251114T101322Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-14 10:13:22,148 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251114T101322Z
20251114/yandex/s3/aws4_request
8740878d7286ae9a74b7f1a88e5e6ec42fe1182af9cea1188783cef64d48927a
2025-11-14 10:13:22,149 - DEBUG - botocore.auth - add_auth: Signature:
b1bac0e2c5193104a55aa9f0a8f5fe0c58a5a91d11cb0e49e84a66082876a250
2025-11-14 10:13:22,149 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function signal_transferring at 0x7facab1e1490>
2025-11-14 10:13:22,154 - DEBUG - botocore.hooks - _emit: Event request-created.s3.GetObject: calling handler <function add_retry_headers at 0x7facac23d490>
2025-11-14 10:13:22,155 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=True, method=GET, url=http://localhost:20364/fbucket/common/simple_format/json_each_row/ptjudsej0cgn96m9v3hp_0_y8u97ZwWQ0OZVZ72udKi-QDgloLuporg.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'20251114T101322Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251114/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=b1bac0e2c5193104a55aa9f0a8f5fe0c58a5a91d11cb0e49e84a66082876a250', 'amz-sdk-invocation-id': b'5d3d40d8-61e3-414a-b4da-4fb7740403a3', 'amz-sdk-request': b'attempt=1'}>
2025-11-14 10:13:22,164 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.9', 'Date': 'Fri, 14 Nov 2025 10:13:22 GMT', 'x-amz-version-id': 'null', 'content-type': 'binary/octet-stream', 'ETag': '"12d351f710dc1c1177b3b8e30a7ee5ab"', 'last-modified': 'Fri, 14 Nov 2025 10:13:21 GMT', 'Content-Length': '122', 'x-amzn-requestid': 'kUgUf6HCJPVZrWI6DUw3e4LBHCS9E8ZB7KWFSdhDjtQmb16x3JYL', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-14 10:13:22,166 - DEBUG - botocore.parsers - parse: Response body:
<botocore.response.StreamingBody object at 0x7fac8e3f5130>
2025-11-14 10:13:22,168 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7fac8d47e2c0>
2025-11-14 10:13:22,168 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-14 10:13:22,169 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.GetObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7fac8d5a29a0>>
2025-11-14 10:13:22,170 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) about to wait for the following futures []
2025-11-14 10:13:22,170 - DEBUG - s3transfer.tasks - _wait_until_all_complete: IOWriteTask(transfer_id=0, {'offset': 0}) done waiting for dependent futures
2025-11-14 10:13:22,175 - DEBUG - s3transfer.tasks - _execute_main: Executing task IOWriteTask(transfer_id=0, {'offset': 0}) with kwargs {'fileobj': <_io.BytesIO object at 0x7fac8d242900>, 'offset': 0}
2025-11-14 10:13:22,175 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) about to wait for the following futures []
2025-11-14 10:13:22,175 - DEBUG - s3transfer.tasks - _wait_until_all_complete: CompleteDownloadNOOPTask(transfer_id=0, {}) done waiting for dependent futures
2025-11-14 10:13:22,176 - DEBUG - s3transfer.tasks - _execute_main: Executing task CompleteDownloadNOOPTask(transfer_id=0, {}) with kwargs {}
2025-11-14 10:13:22,177 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-14 10:13:22,186 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-14 10:17:41,825 - DEBUG - ya.test - _verify_test: Verifying [test_format_setting.TestS3.test_timestamp_simple_format_insert[v2-common/simple_format/test.json-json_each_row] in ydb/tests/fq/s3] canonical results
2025-11-14 10:17:41,827 - DEBUG - ya.test - verify: Test test_format_setting.TestS3.test_timestamp_simple_format_insert[v2-common/simple_format/test.json-json_each_row] status: good
