2025-11-10 09:36:18,816 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 09:36:18,817 - INFO - ya.test - pytest_runtest_setup: test_timestamp_simple_posix[v2-common/simple_posix/test.csv-csv_with_names]
2025-11-10 09:36:18,817 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 09:36:18,817 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-10 09:36:18,913 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_format_setting.py::TestS3, test_name: test_timestamp_simple_posix[v2-common/simple_posix/test.csv-csv_with_names])
2025-11-10 09:36:18,914 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f61bd189e50>
2025-11-10 09:36:18,917 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f61bd2ad610>
2025-11-10 09:36:18,930 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f61bb9be750>
2025-11-10 09:36:18,931 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f61bd2ad310>
2025-11-10 09:36:18,934 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-11-10 09:36:18,940 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-11-10 09:36:18,945 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-11-10 09:36:18,952 - DEBUG - botocore.utils - register: Registering S3Express Identity Resolver
2025-11-10 09:36:18,960 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:s3
2025-11-10 09:36:18,974 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:Bucket
2025-11-10 09:36:18,986 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming Bucket attribute name
2025-11-10 09:36:18,988 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.Bucket: calling handler <function lazy_call.<locals>._handler at 0x7f61bb9bf1d0>
2025-11-10 09:36:18,988 - DEBUG - boto3.resources.action - __call__: Calling s3:create_bucket with {'Bucket': 'fbucket', 'ACL': 'public-read'}
2025-11-10 09:36:18,989 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function validate_bucket_name at 0x7f61bd18bd10>
2025-11-10 09:36:18,990 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f61bd1b65d0>
2025-11-10 09:36:18,990 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:18,990 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <bound method ClientCreator._inject_s3_input_parameters of <botocore.client.ClientCreator object at 0x7f61a037cc90>>
2025-11-10 09:36:18,990 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.CreateBucket: calling handler <function generate_idempotent_uuid at 0x7f61bd18bad0>
2025-11-10 09:36:18,991 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f61bd1b6810>
2025-11-10 09:36:18,991 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:18,991 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:26482', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableAccessPoints': True, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True, 'UseS3ExpressControlEndpoint': True}
2025-11-10 09:36:18,993 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:26482/fbucket
2025-11-10 09:36:19,002 - 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-10 09:36:19,003 - 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-10 09:36:19,004 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_expect_header at 0x7f61bd1b41d0>
2025-11-10 09:36:19,004 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <bound method S3ExpressIdentityResolver.apply_signing_cache_key of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,004 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function add_recursion_detection_header at 0x7f61bd18a090>
2025-11-10 09:36:19,004 - DEBUG - botocore.hooks - _emit: Event before-call.s3.CreateBucket: calling handler <function inject_api_version_header_if_needed at 0x7f61bd1b5c10>
2025-11-10 09:36:19,005 - 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.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource'}, 'body': b'', 'auth_path': '/fbucket/', 'url': 'http://localhost:26482/fbucket', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f619fa09a50>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'ACL': 'public-read'}}, 'input_params': {'Bucket': 'fbucket'}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'endpoint_properties': {'authSchemes': [{'disableDoubleEncoding': True, 'name': 'sigv4', 'signingName': 's3', 'signingRegion': 'yandex'}]}}}
2025-11-10 09:36:19,006 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f619fa08e70>>
2025-11-10 09:36:19,010 - 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 0x7f61a037cc90>>
2025-11-10 09:36:19,011 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.CreateBucket: calling handler <function set_operation_specific_signer at 0x7f61bd18b950>
2025-11-10 09:36:19,011 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.CreateBucket: calling handler <function remove_arn_from_signing_path at 0x7f61bd1b6750>
2025-11-10 09:36:19,011 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.CreateBucket: calling handler <bound method S3ExpressIdentityResolver.resolve_s3express_identity of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,012 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-10 09:36:19,023 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket

host:localhost:26482
x-amz-acl:public-read
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251110T093619Z

host;x-amz-acl;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-10 09:36:19,023 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251110T093619Z
20251110/yandex/s3/aws4_request
e7f76d8e2a52d871cf0aa9b2fb31a073c6329197b5054a376d93b7fac58558c2
2025-11-10 09:36:19,024 - DEBUG - botocore.auth - add_auth: Signature:
6eed5f4243010e112447ea1ecd1db125c2e59a623615d180fc6c67bed8e60b20
2025-11-10 09:36:19,024 - DEBUG - botocore.hooks - _emit: Event request-created.s3.CreateBucket: calling handler <function add_retry_headers at 0x7f61bd1b6510>
2025-11-10 09:36:19,025 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:26482/fbucket, headers={'x-amz-acl': b'public-read', 'User-Agent': b'Boto3/1.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource', 'X-Amz-Date': b'20251110T093619Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251110/yandex/s3/aws4_request, SignedHeaders=host;x-amz-acl;x-amz-content-sha256;x-amz-date, Signature=6eed5f4243010e112447ea1ecd1db125c2e59a623615d180fc6c67bed8e60b20', 'amz-sdk-invocation-id': b'a9d41949-756c-40b9-b4d6-773343d76b4d', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2025-11-10 09:36:19,039 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.12', 'Date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': 'FesRbIsMQ80vRy0jtr1I2jdR9wzLO8zDY0a5JPKtjaPdYRYzO5H4', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '161', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-10 09:36:19,040 - 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-10 09:36:19,042 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <botocore.retryhandler.RetryHandler object at 0x7f619fca5b40>
2025-11-10 09:36:19,043 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-10 09:36:19,043 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.CreateBucket: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,044 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'FesRbIsMQ80vRy0jtr1I2jdR9wzLO8zDY0a5JPKtjaPdYRYzO5H4', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.12', 'date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': 'FesRbIsMQ80vRy0jtr1I2jdR9wzLO8zDY0a5JPKtjaPdYRYzO5H4', 'content-type': 'text/html; charset=utf-8', 'content-length': '161', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}}
2025-11-10 09:36:19,045 - DEBUG - boto3.resources.collection - pages: Calling paginated s3:list_objects with {'Bucket': 'fbucket'}
2025-11-10 09:36:19,046 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function set_list_objects_encoding_type_url at 0x7f61bd1b5610>
2025-11-10 09:36:19,046 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function validate_bucket_name at 0x7f61bd18bd10>
2025-11-10 09:36:19,046 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f61bd1b65d0>
2025-11-10 09:36:19,046 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,047 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <bound method ClientCreator._inject_s3_input_parameters of <botocore.client.ClientCreator object at 0x7f61a037cc90>>
2025-11-10 09:36:19,047 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.ListObjects: calling handler <function generate_idempotent_uuid at 0x7f61bd18bad0>
2025-11-10 09:36:19,047 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f61bd1b6810>
2025-11-10 09:36:19,048 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,048 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:26482', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-10 09:36:19,049 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:26482/fbucket
2025-11-10 09:36:19,050 - 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-10 09:36:19,050 - 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-10 09:36:19,051 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_expect_header at 0x7f61bd1b41d0>
2025-11-10 09:36:19,053 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <bound method S3ExpressIdentityResolver.apply_signing_cache_key of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,054 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function add_recursion_detection_header at 0x7f61bd18a090>
2025-11-10 09:36:19,054 - DEBUG - botocore.hooks - _emit: Event before-call.s3.ListObjects: calling handler <function inject_api_version_header_if_needed at 0x7f61bd1b5c10>
2025-11-10 09:36:19,054 - 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.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource'}, 'body': b'', 'auth_path': '/fbucket/', 'url': 'http://localhost:26482/fbucket?encoding-type=url', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f619fa09a50>, 'has_streaming_input': False, 'auth_type': 'v4', 'encoding_type_auto_set': True, 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'EncodingType': 'url'}}, 'input_params': {'Bucket': 'fbucket'}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'endpoint_properties': {'authSchemes': [{'disableDoubleEncoding': True, 'name': 'sigv4', 'signingName': 's3', 'signingRegion': 'yandex'}]}}}
2025-11-10 09:36:19,055 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f619fa08e70>>
2025-11-10 09:36:19,056 - 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 0x7f61a037cc90>>
2025-11-10 09:36:19,056 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.ListObjects: calling handler <function set_operation_specific_signer at 0x7f61bd18b950>
2025-11-10 09:36:19,057 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <function remove_arn_from_signing_path at 0x7f61bd1b6750>
2025-11-10 09:36:19,057 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.ListObjects: calling handler <bound method S3ExpressIdentityResolver.resolve_s3express_identity of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,058 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-10 09:36:19,058 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
GET
/fbucket
encoding-type=url
host:localhost:26482
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20251110T093619Z

host;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2025-11-10 09:36:19,058 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251110T093619Z
20251110/yandex/s3/aws4_request
e3207113097d6c72a2162185d86ec93da283a5270c51f766a0e806da69c0c02e
2025-11-10 09:36:19,058 - DEBUG - botocore.auth - add_auth: Signature:
d7ae291339779459fd16f816e84c10bc2251fdce2100faa2c932e0f5c6336f40
2025-11-10 09:36:19,061 - DEBUG - botocore.hooks - _emit: Event request-created.s3.ListObjects: calling handler <function add_retry_headers at 0x7f61bd1b6510>
2025-11-10 09:36:19,061 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=GET, url=http://localhost:26482/fbucket?encoding-type=url, headers={'User-Agent': b'Boto3/1.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource', 'X-Amz-Date': b'20251110T093619Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251110/yandex/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=d7ae291339779459fd16f816e84c10bc2251fdce2100faa2c932e0f5c6336f40', 'amz-sdk-invocation-id': b'acd1bfcd-8be4-420b-97bb-41d55f3933f3', 'amz-sdk-request': b'attempt=1'}>
2025-11-10 09:36:19,071 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.12', 'Date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': '3ziOjJWfECcCUJ0gS8ixUcfboYRWwgO06b1X1jxDlcCI5HrmVUmX', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '578', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-10 09:36:19,071 - 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_posix/test.parquet</Key><LastModified>2025-11-10T09:36:17.000Z</LastModified><ETag>&#34;063908950cb61e1706990b4b1d9617d6&#34;</ETag><Size>1146</Size><StorageClass>STANDARD</StorageClass><Owner><ID>75aa57f09aa0c8caeab4f8c24e99d10f8e7faeebf76c078efc7c6caea54ba06a</ID><DisplayName>webfile</DisplayName></Owner></Contents></ListBucketResult>'
2025-11-10 09:36:19,074 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f619fca5b40>
2025-11-10 09:36:19,075 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-10 09:36:19,075 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.ListObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,075 - DEBUG - botocore.hooks - _emit: Event after-call.s3.ListObjects: calling handler <function decode_list_object at 0x7f61bd1b56d0>
2025-11-10 09:36:19,076 - DEBUG - boto3.resources.factory - load_from_definition: Loading s3:ObjectSummary
2025-11-10 09:36:19,076 - DEBUG - boto3.resources.model - _load_name_with_category: Renaming ObjectSummary attribute key
2025-11-10 09:36:19,077 - DEBUG - botocore.hooks - _emit: Event creating-resource-class.s3.ObjectSummary: calling handler <function lazy_call.<locals>._handler at 0x7f61bb9bf350>
2025-11-10 09:36:19,078 - DEBUG - boto3.resources.action - __call__: Calling s3:delete_objects with {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_posix/test.parquet'}]}}
2025-11-10 09:36:19,079 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function validate_bucket_name at 0x7f61bd18bd10>
2025-11-10 09:36:19,079 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f61bd1b65d0>
2025-11-10 09:36:19,079 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,080 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <bound method ClientCreator._inject_s3_input_parameters of <botocore.client.ClientCreator object at 0x7f61a037cc90>>
2025-11-10 09:36:19,080 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.DeleteObjects: calling handler <function generate_idempotent_uuid at 0x7f61bd18bad0>
2025-11-10 09:36:19,080 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f61bd1b6810>
2025-11-10 09:36:19,080 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,081 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:26482', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-10 09:36:19,081 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:26482/fbucket
2025-11-10 09:36:19,081 - 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-10 09:36:19,081 - 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-10 09:36:19,083 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function escape_xml_payload at 0x7f61bd18b710>
2025-11-10 09:36:19,083 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function conditionally_calculate_checksum at 0x7f61bd3bb950>
2025-11-10 09:36:19,083 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_expect_header at 0x7f61bd1b41d0>
2025-11-10 09:36:19,090 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <bound method S3ExpressIdentityResolver.apply_signing_cache_key of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,091 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function add_recursion_detection_header at 0x7f61bd18a090>
2025-11-10 09:36:19,091 - DEBUG - botocore.hooks - _emit: Event before-call.s3.DeleteObjects: calling handler <function inject_api_version_header_if_needed at 0x7f61bd1b5c10>
2025-11-10 09:36:19,091 - 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.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource', 'Content-MD5': 'I20oj4TYNGdikv9C1OIQUg=='}, 'body': b'<Delete xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Object><Key>common/simple_posix/test.parquet</Key></Object></Delete>', 'auth_path': '/fbucket/', 'url': 'http://localhost:26482/fbucket?delete', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f619fa09a50>, 'has_streaming_input': False, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_posix/test.parquet'}]}}}, 'input_params': {'Bucket': 'fbucket', 'Delete': {'Objects': [{'Key': 'common/simple_posix/test.parquet'}]}}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'endpoint_properties': {'authSchemes': [{'disableDoubleEncoding': True, 'name': 'sigv4', 'signingName': 's3', 'signingRegion': 'yandex'}]}, 'checksum': {'request_algorithm': 'conditional-md5'}}}
2025-11-10 09:36:19,092 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f619fa08e70>>
2025-11-10 09:36:19,093 - 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 0x7f61a037cc90>>
2025-11-10 09:36:19,093 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.DeleteObjects: calling handler <function set_operation_specific_signer at 0x7f61bd18b950>
2025-11-10 09:36:19,094 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.DeleteObjects: calling handler <function remove_arn_from_signing_path at 0x7f61bd1b6750>
2025-11-10 09:36:19,094 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.DeleteObjects: calling handler <bound method S3ExpressIdentityResolver.resolve_s3express_identity of <botocore.utils.S3ExpressIdentityResolver object at 0x7f619fca4740>>
2025-11-10 09:36:19,094 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-10 09:36:19,094 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
POST
/fbucket
delete=
content-md5:I20oj4TYNGdikv9C1OIQUg==
host:localhost:26482
x-amz-content-sha256:7b1e99d95814551b09041bf592fa4f5630067fad2db3ab349c610e7d1aa6274c
x-amz-date:20251110T093619Z

content-md5;host;x-amz-content-sha256;x-amz-date
7b1e99d95814551b09041bf592fa4f5630067fad2db3ab349c610e7d1aa6274c
2025-11-10 09:36:19,095 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251110T093619Z
20251110/yandex/s3/aws4_request
5fb979254e3479a3c9918c08e590d7d8231d4209fe2b71008a5124a637a35a0e
2025-11-10 09:36:19,095 - DEBUG - botocore.auth - add_auth: Signature:
4208f9facdfa6d0d25bd38802d5379a64e11bab84252bc8c59b759d558884201
2025-11-10 09:36:19,095 - DEBUG - botocore.hooks - _emit: Event request-created.s3.DeleteObjects: calling handler <function add_retry_headers at 0x7f61bd1b6510>
2025-11-10 09:36:19,096 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=POST, url=http://localhost:26482/fbucket?delete, headers={'User-Agent': b'Boto3/1.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89 Resource', 'Content-MD5': b'I20oj4TYNGdikv9C1OIQUg==', 'X-Amz-Date': b'20251110T093619Z', 'X-Amz-Content-SHA256': b'7b1e99d95814551b09041bf592fa4f5630067fad2db3ab349c610e7d1aa6274c', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251110/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=4208f9facdfa6d0d25bd38802d5379a64e11bab84252bc8c59b759d558884201', 'amz-sdk-invocation-id': b'd94a18f8-7850-4f06-be40-7d9dec8ff8c9', 'amz-sdk-request': b'attempt=1', 'Content-Length': '125'}>
2025-11-10 09:36:19,106 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.12', 'Date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': 'rGPtUAtyhaUSKxZyQAaiTAnPpZDyGcU6JRYO6RuyzkQQW2sif342', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '176', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-10 09:36:19,111 - 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_posix/test.parquet</Key></Deleted></DeleteResult>'
2025-11-10 09:36:19,113 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <botocore.retryhandler.RetryHandler object at 0x7f619fca5b40>
2025-11-10 09:36:19,113 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-10 09:36:19,113 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.DeleteObjects: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619fca5aa0>>
2025-11-10 09:36:19,114 - DEBUG - boto3.resources.action - __call__: Response: {'ResponseMetadata': {'RequestId': 'rGPtUAtyhaUSKxZyQAaiTAnPpZDyGcU6JRYO6RuyzkQQW2sif342', 'HTTPStatusCode': 200, 'HTTPHeaders': {'server': 'Werkzeug/2.2.3 Python/3.12.12', 'date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': 'rGPtUAtyhaUSKxZyQAaiTAnPpZDyGcU6JRYO6RuyzkQQW2sif342', 'content-type': 'text/html; charset=utf-8', 'content-length': '176', 'access-control-allow-origin': '*', 'connection': 'close'}, 'RetryAttempts': 0}, 'Deleted': [{'Key': 'common/simple_posix/test.parquet'}]}
2025-11-10 09:36:19,114 - DEBUG - botocore.hooks - _emit: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f61bd189e50>
2025-11-10 09:36:19,117 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f61bd2ad610>
2025-11-10 09:36:19,117 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f61bb9be750>
2025-11-10 09:36:19,117 - DEBUG - botocore.hooks - _emit: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f61bd2ad310>
2025-11-10 09:36:19,120 - DEBUG - botocore.endpoint - create_endpoint: Setting s3 timeout as (60, 60)
2025-11-10 09:36:19,128 - DEBUG - botocore.client - _register_legacy_retries: Registering retry handlers for service: s3
2025-11-10 09:36:19,138 - DEBUG - botocore.utils - register: Registering S3 region redirector handler
2025-11-10 09:36:19,139 - DEBUG - botocore.utils - register: Registering S3Express Identity Resolver
2025-11-10 09:36:19,140 - DEBUG - boto3.s3.transfer - _should_use_crt: Opting out of CRT Transfer Manager. Preferred client: auto, CRT available: False, Instance Optimized: False.
2025-11-10 09:36:19,140 - DEBUG - boto3.s3.transfer - create_transfer_manager: Using default client. pid: 187584, thread: 140057856185472
2025-11-10 09:36:19,141 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-10 09:36:19,146 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f61a033b710>}) about to wait for the following futures []
2025-11-10 09:36:19,147 - DEBUG - s3transfer.tasks - _wait_until_all_complete: UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f61a033b710>}) done waiting for dependent futures
2025-11-10 09:36:19,147 - DEBUG - s3transfer.tasks - _execute_main: Executing task UploadSubmissionTask(transfer_id=0, {'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f61a033b710>}) with kwargs {'client': <botocore.client.S3 object at 0x7f61a04479e0>, 'config': <boto3.s3.transfer.TransferConfig object at 0x7f619f579c30>, 'osutil': <s3transfer.utils.OSUtils object at 0x7f61a033b3f0>, 'request_executor': <s3transfer.futures.BoundedExecutor object at 0x7f61a03386f0>, 'transfer_future': <s3transfer.futures.TransferFuture object at 0x7f61a033b710>}
2025-11-10 09:36:19,147 - DEBUG - s3transfer.futures - submit: Submitting task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_posix/test.csv', 'extra_args': {}}) to executor <s3transfer.futures.BoundedExecutor object at 0x7f61a03386f0> for transfer request: 0.
2025-11-10 09:36:19,148 - DEBUG - s3transfer.utils - acquire: Acquiring 0
2025-11-10 09:36:19,157 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_posix/test.csv', 'extra_args': {}}) about to wait for the following futures []
2025-11-10 09:36:19,157 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-10 09:36:19,158 - DEBUG - s3transfer.tasks - _wait_until_all_complete: PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_posix/test.csv', 'extra_args': {}}) done waiting for dependent futures
2025-11-10 09:36:19,158 - DEBUG - s3transfer.tasks - _execute_main: Executing task PutObjectTask(transfer_id=0, {'bucket': 'fbucket', 'key': 'common/simple_posix/test.csv', 'extra_args': {}}) with kwargs {'client': <botocore.client.S3 object at 0x7f61a04479e0>, 'fileobj': <s3transfer.utils.ReadFileChunk object at 0x7f61a03381a0>, 'bucket': 'fbucket', 'key': 'common/simple_posix/test.csv', 'extra_args': {}}
2025-11-10 09:36:19,160 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_ascii_metadata at 0x7f61bd1b4dd0>
2025-11-10 09:36:19,160 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function sse_md5 at 0x7f61bd18bdd0>
2025-11-10 09:36:19,160 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function convert_body_to_file_like_object at 0x7f61bd1b5a90>
2025-11-10 09:36:19,161 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function validate_bucket_name at 0x7f61bd18bd10>
2025-11-10 09:36:19,161 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function remove_bucket_from_url_paths_from_model at 0x7f61bd1b65d0>
2025-11-10 09:36:19,161 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.annotate_request_context of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619f5ee4a0>>
2025-11-10 09:36:19,161 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <bound method ClientCreator._inject_s3_input_parameters of <botocore.client.ClientCreator object at 0x7f619f57b300>>
2025-11-10 09:36:19,161 - DEBUG - botocore.hooks - _emit: Event before-parameter-build.s3.PutObject: calling handler <function generate_idempotent_uuid at 0x7f61bd18bad0>
2025-11-10 09:36:19,162 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <function customize_endpoint_resolver_builtins at 0x7f61bd1b6810>
2025-11-10 09:36:19,162 - DEBUG - botocore.hooks - _emit: Event before-endpoint-resolution.s3: calling handler <bound method S3RegionRedirectorv2.redirect_from_cache of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619f5ee4a0>>
2025-11-10 09:36:19,163 - DEBUG - botocore.regions - construct_endpoint: Calling endpoint provider with parameters: {'Bucket': 'fbucket', 'Region': 'yandex', 'UseFIPS': False, 'UseDualStack': False, 'Endpoint': 'http://localhost:26482', 'ForcePathStyle': True, 'Accelerate': False, 'UseGlobalEndpoint': False, 'Key': 'common/simple_posix/test.csv', 'DisableMultiRegionAccessPoints': False, 'UseArnRegion': True}
2025-11-10 09:36:19,164 - DEBUG - botocore.regions - construct_endpoint: Endpoint provider result: http://localhost:26482/fbucket
2025-11-10 09:36:19,165 - 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-10 09:36:19,165 - 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-10 09:36:19,166 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function conditionally_calculate_checksum at 0x7f61bd3bb950>
2025-11-10 09:36:19,166 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_expect_header at 0x7f61bd1b41d0>
2025-11-10 09:36:19,167 - DEBUG - botocore.handlers - add_expect_header: Adding expect 100 continue header to request.
2025-11-10 09:36:19,167 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <bound method S3ExpressIdentityResolver.apply_signing_cache_key of <botocore.utils.S3ExpressIdentityResolver object at 0x7f61a0339e10>>
2025-11-10 09:36:19,167 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function add_recursion_detection_header at 0x7f61bd18a090>
2025-11-10 09:36:19,167 - DEBUG - botocore.hooks - _emit: Event before-call.s3.PutObject: calling handler <function inject_api_version_header_if_needed at 0x7f61bd1b5c10>
2025-11-10 09:36:19,168 - DEBUG - botocore.endpoint - make_request: Making request for OperationModel(name=PutObject) with params: {'url_path': '/common/simple_posix/test.csv', 'query_string': {}, 'method': 'PUT', 'headers': {'User-Agent': 'Boto3/1.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89', 'Content-MD5': 'xFjVOqRQWiI/8KaEqZYoAQ==', 'Expect': '100-continue'}, 'body': <s3transfer.utils.ReadFileChunk object at 0x7f61a03381a0>, 'auth_path': '/fbucket/common/simple_posix/test.csv', 'url': 'http://localhost:26482/fbucket/common/simple_posix/test.csv', 'context': {'client_region': 'yandex', 'client_config': <botocore.config.Config object at 0x7f619f43a900>, 'has_streaming_input': True, 'auth_type': 'v4', 's3_redirect': {'redirected': False, 'bucket': 'fbucket', 'params': {'Bucket': 'fbucket', 'Key': 'common/simple_posix/test.csv', 'Body': <s3transfer.utils.ReadFileChunk object at 0x7f61a03381a0>}}, 'input_params': {'Bucket': 'fbucket', 'Key': 'common/simple_posix/test.csv'}, 'signing': {'region': 'yandex', 'signing_name': 's3', 'disableDoubleEncoding': True}, 'endpoint_properties': {'authSchemes': [{'disableDoubleEncoding': True, 'name': 'sigv4', 'signingName': 's3', 'signingRegion': 'yandex'}]}}}
2025-11-10 09:36:19,169 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_not_transferring at 0x7f61a02cebd0>
2025-11-10 09:36:19,169 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f619f43b530>>
2025-11-10 09:36:19,170 - 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 0x7f619f57b300>>
2025-11-10 09:36:19,170 - DEBUG - botocore.hooks - _emit: Event choose-signer.s3.PutObject: calling handler <function set_operation_specific_signer at 0x7f61bd18b950>
2025-11-10 09:36:19,171 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.PutObject: calling handler <function remove_arn_from_signing_path at 0x7f61bd1b6750>
2025-11-10 09:36:19,171 - DEBUG - botocore.hooks - _emit: Event before-sign.s3.PutObject: calling handler <bound method S3ExpressIdentityResolver.resolve_s3express_identity of <botocore.utils.S3ExpressIdentityResolver object at 0x7f61a0339e10>>
2025-11-10 09:36:19,172 - DEBUG - botocore.auth - add_auth: Calculating signature using v4 auth.
2025-11-10 09:36:19,172 - DEBUG - botocore.auth - add_auth: CanonicalRequest:
PUT
/fbucket/common/simple_posix/test.csv

content-md5:xFjVOqRQWiI/8KaEqZYoAQ==
host:localhost:26482
x-amz-content-sha256:370d6d54aa93fc85eb6ff024dedb902d2613e11062cd845f34a9833c3f2f6f67
x-amz-date:20251110T093619Z

content-md5;host;x-amz-content-sha256;x-amz-date
370d6d54aa93fc85eb6ff024dedb902d2613e11062cd845f34a9833c3f2f6f67
2025-11-10 09:36:19,172 - DEBUG - botocore.auth - add_auth: StringToSign:
AWS4-HMAC-SHA256
20251110T093619Z
20251110/yandex/s3/aws4_request
4c490fe56ba511e6d5594d0e9d4e8e44aae983a5a23915a47c8ef7ece4c9f08e
2025-11-10 09:36:19,173 - DEBUG - botocore.auth - add_auth: Signature:
75a76d042a462ddfbd10cdc842e52065329aeebd261c2f8fabf795be520504c7
2025-11-10 09:36:19,173 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function signal_transferring at 0x7f61a02cec90>
2025-11-10 09:36:19,173 - DEBUG - botocore.hooks - _emit: Event request-created.s3.PutObject: calling handler <function add_retry_headers at 0x7f61bd1b6510>
2025-11-10 09:36:19,174 - DEBUG - botocore.endpoint - _do_get_response: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://localhost:26482/fbucket/common/simple_posix/test.csv, headers={'User-Agent': b'Boto3/1.34.89 md/Botocore#1.34.89 ua/2.0 os/linux#5.15.0-157-generic md/arch#x86_64 lang/python#3.12.12 md/pyimpl#CPython cfg/retry-mode#legacy Botocore/1.34.89', 'Content-MD5': b'xFjVOqRQWiI/8KaEqZYoAQ==', 'Expect': b'100-continue', 'X-Amz-Date': b'20251110T093619Z', 'X-Amz-Content-SHA256': b'370d6d54aa93fc85eb6ff024dedb902d2613e11062cd845f34a9833c3f2f6f67', 'Authorization': b'AWS4-HMAC-SHA256 Credential=key/20251110/yandex/s3/aws4_request, SignedHeaders=content-md5;host;x-amz-content-sha256;x-amz-date, Signature=75a76d042a462ddfbd10cdc842e52065329aeebd261c2f8fabf795be520504c7', 'amz-sdk-invocation-id': b'942dda46-95f6-412f-85f4-a6848675106d', 'amz-sdk-request': b'attempt=1', 'Content-Length': '88'}>
2025-11-10 09:36:19,176 - DEBUG - botocore.awsrequest - _send_output: Waiting for 100 Continue response.
2025-11-10 09:36:19,178 - DEBUG - botocore.awsrequest - _handle_expect_response: 100 Continue response seen, now sending request body.
2025-11-10 09:36:19,182 - DEBUG - botocore.parsers - parse: Response headers: {'Server': 'Werkzeug/2.2.3 Python/3.12.12', 'Date': 'Mon, 10 Nov 2025 09:36:19 GMT', 'ETag': '"c458d53aa4505a223ff0a684a9962801"', 'last-modified': 'Mon, 10 Nov 2025 09:36:19 GMT', 'x-amzn-requestid': 'GpwAtnt4k9JoanvumwrhdUuwSOLlT31Z2TJnDL9K7dudcEOS9PT9', 'Content-Type': 'text/html; charset=utf-8', 'Content-Length': '0', 'Access-Control-Allow-Origin': '*', 'Connection': 'close'}
2025-11-10 09:36:19,183 - DEBUG - botocore.parsers - parse: Response body:
b''
2025-11-10 09:36:19,184 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f61a0339410>
2025-11-10 09:36:19,184 - DEBUG - botocore.retryhandler - __call__: No retry needed.
2025-11-10 09:36:19,184 - DEBUG - botocore.hooks - _emit: Event needs-retry.s3.PutObject: calling handler <bound method S3RegionRedirectorv2.redirect_from_error of <botocore.utils.S3RegionRedirectorv2 object at 0x7f619f5ee4a0>>
2025-11-10 09:36:19,185 - DEBUG - s3transfer.utils - release: Releasing acquire 0/None
2025-11-10 09:36:19,187 - DEBUG - root - wait_bootstrap: Wait for node 1 to bootstrap
2025-11-10 09:36:19,220 - DEBUG - root - wait_bootstrap: Node 1 has been bootstrapped
2025-11-10 09:36:19,325 - DEBUG - root - create_query_impl: Request: content {
  type: ANALYTICS
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            SELECT *\n            FROM bindings.`h9122491696591086242_test_timestamp_simple_posixmy_binding`\n            "
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "e2f79b1b-0cb7-4b93-847f-739881a7d927"

2025-11-10 09:36:19,345 - DEBUG - root - create_query_impl: Result: query_id: "ptqudsomu8h2v9hidl2o"

2025-11-10 09:36:19,355 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudsomu8h2v9hidl2o"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1762767379
        nanos: 330008000
      }
      modified_at {
        seconds: 1762767379
        nanos: 330008000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudsomu8h2v3klvamu-ptqudsomu8h2v9hidl2o"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1762767379
      nanos: 330008000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            SELECT *\n            FROM bindings.`h9122491696591086242_test_timestamp_simple_posixmy_binding`\n            "
    syntax: YQL_V1
  }
}

2025-11-10 09:36:19,865 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudsomu8h2v9hidl2o"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1762767379
        nanos: 330008000
      }
      modified_at {
        seconds: 1762767379
        nanos: 330008000
      }
      revision: 1
    }
    started_at {
      seconds: 1762767379
      nanos: 510000000
    }
    finished_at {
      seconds: 1762767379
      nanos: 758000000
    }
    execute_mode: RUN
    status: COMPLETED
    last_job_query_revision: 1
    last_job_id: "ptjudsomu8h2v3klvamu-ptqudsomu8h2v9hidl2o"
    result_expire_at {
      seconds: 1762853779
      nanos: 498522000
    }
    started_by: "root@builtin"
    submitted_at {
      seconds: 1762767379
      nanos: 330008000
    }
  }
  content {
    type: ANALYTICS
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            SELECT *\n            FROM bindings.`h9122491696591086242_test_timestamp_simple_posixmy_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\":\"39.11111111\",\"Format\":\"csv_with_names\",\"Name\":\"h9122491696591086242_test_timestamp_simple_posixmy_binding\",\"Inputs\":[],\"Path\":\"common/simple_posix/test.csv \",\"E-Rows\":\"0.8888888889\",\"ExternalDataSource\":\"h9122491696591086242_test_timestamp_simple_posixfruitbucket\",\"ReadColumns\":[\"Fruit\",\"Price\",\"Time\",\"Weight\"],\"SourceType\":\"s3\",\"E-Cost\":\"88\"}],\"Node Type\":\"Source\"}],\"Node Type\":\"Stage\"}],\"Node Type\":\"UnionAll\",\"PlanNodeType\":\"Connection\"}],\"Node Type\":\"Collect\"}],\"Node Type\":\"ResultSet\",\"PlanNodeType\":\"ResultSet\"}],\"Node Type\":\"Query\",\"PlanNodeType\":\"Query\"},\"meta\":{\"version\":\"0.2\",\"type\":\"query\"}}"
  }
  statistics {
    json: "{\"ResultSet\":{\"Tasks\":{\"sum\":2,\"count\":2,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"455us\",\"count\":2,\"avg\":\"227us\",\"max\":\"372us\",\"min\":\"83us\"},\"IngressBytes\":{\"sum\":88,\"count\":1,\"avg\":88,\"max\":88,\"min\":88},\"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\":82,\"count\":2,\"avg\":41,\"max\":41,\"min\":41},\"OutputRows\":{\"sum\":4,\"count\":2,\"avg\":2,\"max\":2,\"min\":2},\"ResultBytes\":{\"sum\":41,\"count\":1,\"avg\":41,\"max\":41,\"min\":41},\"ResultRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"MaxMemoryUsage\":{\"sum\":211812352,\"count\":2,\"avg\":105906176,\"max\":210763776,\"min\":1048576}}}"
  }
  result_set_meta {
    column {
      name: "Fruit"
      type {
        type_id: STRING
      }
    }
    column {
      name: "Price"
      type {
        type_id: INT32
      }
    }
    column {
      name: "Time"
      type {
        type_id: TIMESTAMP
      }
    }
    column {
      name: "Weight"
      type {
        type_id: INT32
      }
    }
    rows_count: 2
  }
  ast {
    data: "(\n(let $1 \'\"/local/h9122491696591086242_test_timestamp_simple_posixfruitbucket\")\n(let $2 \'\"/local/h9122491696591086242_test_timestamp_simple_posixmy_binding\")\n(let $3 (DataSource \'\"s3\" $1 $2))\n(let $4 \'\"Paths {\\n  Name: \\\"common\\\"\\n  Children {\\n    Name: \\\"simple_posix\\\"\\n    Children {\\n      Name: \\\"test.csv\\\"\\n      Size: 88\\n      Read: true\\n    }\\n    IsDirectory: true\\n  }\\n  IsDirectory: true\\n}\\n\")\n(let $5 (Bool \'\"true\"))\n(let $6 \'\"cluster:default_/local/h9122491696591086242_test_timestamp_simple_posixfruitbucket\")\n(let $7 (DataType \'Int32))\n(let $8 (StructType \'(\'\"Fruit\" (DataType \'String)) \'(\'\"Price\" $7) \'(\'\"Time\" (DataType \'Timestamp)) \'(\'\"Weight\" $7)))\n(let $9 (S3ParseSettings world \'(\'((String $4) $5 (AsStruct))) (SecureParam $6) \'\"\" \'\"common/simple_posix/test.csv \" \'\"csv_with_names\" $8 (lambda \'($14) $5) \'(\'(\'\"data.timestamp.formatname\" \'\"POSIX\"))))\n(let $10 (DqPhyStage \'((DqSource $3 $9)) (lambda \'($15) (block \'(\n  (let $16 (DqSourceWideWrap $15 $3 $8 \'(\'(\'format \'\"csv_with_names\"))))\n  (return (FromFlow (NarrowMap $16 (lambda \'($17 $18 $19 $20) (AsStruct \'(\'\"Fruit\" $17) \'(\'\"Price\" $18) \'(\'\"Time\" $19) \'(\'\"Weight\" $20))))))\n))) \'(\'(\'\"_logical_id\" \'399) \'(\'\"_id\" \'\"d070fdd2-dcac86b0-e713ac6a-d9022b89\"))))\n(let $11 (DqCnUnionAll (TDqOutput $10 \'\"0\")))\n(let $12 (DqPhyStage \'($11) (lambda \'($21) $21) \'(\'(\'\"_logical_id\" \'459) \'(\'\"_id\" \'\"7e7550e2-681cc94f-ce964f6b-d01e5622\"))))\n(let $13 (DqCnResult (TDqOutput $12 \'\"0\") \'()))\n(return (KqpPhysicalQuery \'((KqpPhysicalTx \'($10 $12) \'($13) \'() \'(\'(\'\"type\" \'\"generic\")))) \'((KqpTxResultBinding (ListType $8) \'\"0\" \'\"0\")) \'(\'(\'\"type\" \'\"script\"))))\n)\n"
  }
  timeline {
    svg: "<svg width=\'1280\' height=\'162\' xmlns=\'http://www.w3.org/2000/svg\'>\n<clipPath id=\'clipTextPath\'><rect x=\'0\' y=\'0\' width=\'298\' height=\'162\'/></clipPath>\n\n<defs>\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_ingress\'>\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_egress\'>\n    <path d=\'M13 9H10V16H6V9L3 9V8L8 3L13 8V9Z\' />\n    <path d=\'M14 2H2V0H14V2Z\' />\n  </g>\n\n  <g id=\'icon_input\'>\n    <path d=\"M456.49,264.459L295.206,103.183l56.572-56.572c1.084-1.08,1.456-2.696,0.948-4.14c-0.504-1.448-1.792-2.48-3.316-2.656\n        L4.654,0.027c-1.22-0.144-2.428,0.284-3.292,1.148c-0.864,0.86-1.284,2.068-1.144,3.28L40.01,349.208\n        c0.176,1.52,1.208,2.812,2.656,3.316c1.448,0.508,3.068,0.14,4.144-0.948l56.18-56.18L264.274,456.68\n        c0.748,0.748,1.764,1.172,2.828,1.172c1.06,0,2.076-0.424,2.828-1.172l186.556-186.568\n        C458.05,268.555,458.05,266.027,456.49,264.459z\"/>\n  </g>\n\n  <g id=\'icon_output\'>\n\t<path d=\"M456.494,1.168c-0.864-0.86-2.064-1.284-3.288-1.14l-344.76,39.78c-1.524,0.18-2.812,1.216-3.32,2.656\n        c-0.504,1.456-0.132,3.068,0.948,4.148l56.572,56.576L1.362,264.464c-1.564,1.564-1.564,4.092,0,5.656l186.56,186.556\n        c0.78,0.784,1.804,1.172,2.828,1.172c1.024,0,2.048-0.388,2.828-1.172l161.28-161.28l56.18,56.18\n        c1.084,1.088,2.7,1.452,4.144,0.952c1.448-0.504,2.48-1.796,2.656-3.32L457.63,4.456C457.774,3.248,457.354,2.036,456.494,1.168z\"/>\n  </g>\n\n</defs>\n<style type=\'text/css\'>\n  rect.stage { stroke-width:0; fill:var(--stage-main, #F2F2F2); }\n  rect.clone { stroke-width:0; fill:var(--stage-clone, #D9D9D9); }\n  rect.blocks { stroke-width:0; fill:var(--block-medium, #EACB68); }\n  .texts { text-anchor:start; font-family:Verdana; font-size:8px; fill:var(--stage-text, #262626); }\n  .textm { text-anchor:middle; font-family:Verdana; font-size:8px; fill:var(--stage-text, #262626); }\n  .texte { text-anchor:end; font-family:Verdana; font-size:8px; fill:var(--stage-text, #262626); }\n  circle.stage { stroke:var(--stage-main, #F2F2F2); stroke-width:1; fill:var(--stage-clone, #D9D9D9); }\n  line.opdiv { stroke-width:1; stroke:var(--stage-grid, #B2B2B2); stroke-dasharray:1,2; }\n  text.clipped { clip-path:url(#clipTextPath); }\n  polygon.conn { stroke-width:0; fill:var(--conn-fill, #BFBFBF); }\n  path.conn { stroke-width:1; stroke:var(--conn-fill, #BFBFBF); fill:var(--conn-fill, #BFBFBF); }\n  path.conn.blocks { stroke-width:1; stroke:var(--conn-fill, #BFBFBF); fill:var(--block-medium, #EACB68); }\n  text.conn { text-anchor:middle; font-family:Verdana; font-size:6px; fill:var(--conn-text, #393939); }\n  rect.background { stroke-width:0; fill:#33FFFF; opacity:0; }\n  g.selected circle.stage { fill:#33FFFF; }\n  g.selected polygon.conn { fill:#33FFFF; }\n  g.selected path.conn { stroke:#33FFFF; fill:#33FFFF; }\n  g.selected rect.stage { fill:#33FFFF; }\n  g.selected rect.clone { fill:#33FFFF; }\n  g.selected rect.background { opacity:1; }\n  g.selected path.blocks { stroke:#33FFFF; }\n</style>\n\n<script type=\"text/ecmascript\">\n<![CDATA[\n    var selectedNode;\n\n    function find_selectable(node) {\n\t\tvar parent = node.parentElement;\n\t\tif (!parent) return;\n\t\tif (parent.classList.contains(\"selectable\")) return parent;\n\t\treturn find_selectable(parent);\n\t}\n\n    window.onload = function() {\n        selectedNode = document.querySelector(\".selected\");\n    }\n\n    window.addEventListener(\"click\", function(e) {\n\t\tvar target = find_selectable(e.target);\n        if (target) {\n            if (selectedNode) {\n                selectedNode.classList.remove(\"selected\");\n            }\n            if (target == selectedNode) {\n                selectedNode = null;\n            } else {\n                selectedNode = target;\n                selectedNode.classList.add(\"selected\");\n            }\n        }\n\t}, false)\n]]>\n</script>\n<g class=\'selectable\'><title>Stage 1</title>\n<rect x=\'0\' y=\'27\' width=\'298\' height=\'66\' class=\'stage\'/>\n<rect x=\'301\' y=\'27\' width=\'64\' height=\'66\' class=\'stage\'/>\n<rect x=\'395\' y=\'27\' width=\'200\' height=\'66\' class=\'stage\'/>\n<rect x=\'368\' y=\'27\' width=\'24\' height=\'66\' class=\'stage\'/>\n<rect x=\'598\' y=\'27\' width=\'682\' height=\'66\' class=\'stage\'/>\n<g><title>Collect: </title><text x=\'18\' y=\'38\' class=\'texts clipped\'>Collect</text>\n<text x=\'26\' y=\'48\' class=\'texts clipped\'></text>\n<g><title>Output Rows 33%, 2</title>\n  <rect x=\'303\' y=\'33\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,33 333,33 363,33 363,47 303,47\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'36\' 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=\'44\'>2</text>\n</g>\n</g>\n<circle cx=\'8\' cy=\'60\' r=\'7\' class=\'stage\' />\n<text x=\'8\' y=\'64\' class=\'textm\'>1</text>\n<g><title>Memory 0%, 1.00MB</title>\n<use href=\'#icon_memory\' transform=\'translate(395 45) scale(0.6 0.6)\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n  <rect x=\'413\' y=\'45\' width=\'1\' height=\'14\' stroke-width=\'0\' fill=\'var(--mem-light, #AA7785)\'/>  <polygon points=\'413,45 413,45 414,45 414,59 413,59\' stroke=\'none\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n<rect x=\'413\' y=\'48\' 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=\'56\'>1.00MB</text>\n</g>\n<g><title>Max MEM 1.00MB</title>\n<path d=\'M601,58c0,0,0,-13,0,-13c0,0,0,13,0,13z\' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>CPU Usage 18%, 83us</title>\n<use href=\'#icon_cpu\' transform=\'translate(395 61) scale(0.6 0.6)\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n  <rect x=\'413\' y=\'61\' width=\'40\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,61 433,61 453,61 453,75 413,75\' stroke=\'none\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n<rect x=\'413\' y=\'64\' 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=\'72\'>83us</text>\n</g>\n<g><title>Stage 1, tasks: 1, finished: 1</title>\n<line x1=\'371\' y1=\'27\' x2=\'371\' y2=\'93\' stroke-width=\'6\' stroke=\'var(--stage-text, #262626)\' stroke-dasharray=\'1,1\' />\n  <text x=\'390\' y=\'64\' class=\'texte\'>1</text>\n</g>\n</g>\n<g class=\'selectable\'><title>Stage 0</title>\n<rect x=\'0\' y=\'96\' width=\'298\' height=\'66\' class=\'stage\'/>\n<rect x=\'301\' y=\'96\' width=\'64\' height=\'66\' class=\'stage\'/>\n<rect x=\'395\' y=\'96\' width=\'200\' height=\'66\' class=\'stage\'/>\n<rect x=\'368\' y=\'96\' width=\'24\' height=\'66\' class=\'stage\'/>\n<rect x=\'598\' y=\'96\' width=\'682\' height=\'66\' class=\'stage\'/>\n<g><title>Stage: </title><text x=\'18\' y=\'107\' class=\'texts clipped\'>Stage</text>\n<text x=\'26\' y=\'117\' class=\'texts clipped\'></text>\n<g><title>Output Rows 33%, 2</title>\n  <rect x=\'303\' y=\'102\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,102 333,102 363,102 363,116 303,116\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'105\' 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=\'113\'>2</text>\n</g>\n</g>\n<line x1=\'18\' y1=\'119\' x2=\'298\' y2=\'119\' class=\'opdiv\' />\n<g><title>Source s3: h9122491696591086242_test_timestamp_simple_posixmy_binding(Fruit, Price, Time, Weight)</title><text x=\'18\' y=\'127\' class=\'texts clipped\'>Source s3</text>\n<text x=\'26\' y=\'137\' class=\'texts clipped\'>h9122491696591086242_test_timestamp_simple_posixmy_binding(Fruit, Price, Time, Weight)</text>\n<g><title>Output Rows 33%, 2, Est: 88 Rows: 0 Size: 39B</title>\n  <rect x=\'303\' y=\'122\' width=\'60\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'303,122 333,122 363,122 363,136 303,136\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'303\' y=\'125\' 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=\'133\'>2</text>\n</g>\n</g>\n<circle cx=\'8\' cy=\'129\' r=\'7\' class=\'stage\' />\n<text x=\'8\' y=\'133\' class=\'textm\'>0</text>\n<g><title>Memory 99%, 201.00MB</title>\n<use href=\'#icon_memory\' transform=\'translate(395 114) scale(0.6 0.6)\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n  <rect x=\'413\' y=\'114\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--mem-light, #AA7785)\'/>  <polygon points=\'413,114 503,114 593,114 593,128 413,128\' stroke=\'none\' fill=\'var(--mem-medium, #7E4E5B)\'/>\n<rect x=\'413\' y=\'117\' 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=\'125\'>201.00MB</text>\n</g>\n<g><title>Max MEM 201.00MB</title>\n<path d=\'M598,127c1,0,2,-13,3,-13c0,0,0,13,0,13z\' stroke-width=\'1\' stroke=\'var(--mem-medium, #7E4E5B)\' fill=\'var(--mem-medium, #7E4E5B)\' />\n</g>\n<g><title>CPU Usage 81%, 372us</title>\n<use href=\'#icon_cpu\' transform=\'translate(395 130) scale(0.6 0.6)\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n  <rect x=\'413\' y=\'130\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--cpu-light, #B78C98)\'/>  <polygon points=\'413,130 503,130 593,130 593,144 413,144\' stroke=\'none\' fill=\'var(--cpu-medium, #A36D7B)\'/>\n<rect x=\'413\' y=\'133\' 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=\'141\'>372us</text>\n</g>\n<g><title>Max CPU 1.36</title>\n<path d=\'M598,143c0,0,0,0,1,0c0,0,0,0,1,0c0,0,0,-13,0,-13c0,0,0,11,1,11c0,0,0,2,0,2z\' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n<g><title>Stage 0, tasks: 1, finished: 1</title>\n<line x1=\'371\' y1=\'96\' x2=\'371\' y2=\'162\' stroke-width=\'6\' stroke=\'var(--stage-text, #262626)\' stroke-dasharray=\'1,1\' />\n  <text x=\'390\' y=\'133\' class=\'texte\'>1</text>\n</g>\n<g><title>Ingress 100%, 88B, Rows 100%, 2, Width 44B</title>\n<use href=\'#icon_ingress\' transform=\'translate(395 146) scale(0.9 0.9)\' fill=\'var(--ingress-medium, #466364)\'/>\n  <rect x=\'413\' y=\'146\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--ingress-light, #5A8183)\'/>  <polygon points=\'413,146 503,146 593,146 593,160 413,160\' stroke=\'none\' fill=\'var(--ingress-medium, #466364)\'/>\n<rect x=\'413\' y=\'149\' 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=\'157\'>88B</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=\'601\' y=\'146\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--ingress-medium, #466364)\'/>\n</g>\n</g>\n<g class=\'selectable\'><title>Result: ResultSet</title>\n<rect x=\'0\' y=\'3\' width=\'298\' height=\'24\' class=\'background\'/>\n<text x=\'0\' y=\'11\' class=\'texts\'>ResultSet</text>\n<g><title>Output 50%, 41B, Rows 50%, 2</title>\n<rect x=\'395\' y=\'29\' width=\'200\' height=\'14\' class=\'background\'/>\n<use href=\'#icon_output\' transform=\'translate(395 29) scale(0.0325 0.0325)\' fill=\'var(--output-light, #6F93C3)\'/>\n  <rect x=\'413\' y=\'29\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'413,29 503,29 593,29 593,43 413,43\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'413\' y=\'32\' 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=\'40\'>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=\'601\' y=\'29\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-medium, #5781B9)\'/>\n</g>\n</g>\n<g class=\'selectable\'><title>Connection: UnionAll</title>\n  <path d=\'M16,110l-16,0l0,-14l8,-4l8,4z\' class=\'conn\' />\n<text x=\'8\' y=\'106\' class=\'conn\'>U</text>\n<g><title>Input 100%, 41B, Rows 100%, 2, Width 20B</title>\n<rect x=\'395\' y=\'77\' width=\'200\' height=\'14\' class=\'background\'/>\n<use href=\'#icon_input\' transform=\'translate(395 77) scale(0.0325 0.0325)\' fill=\'var(--input-light, #7CA3A5)\'/>\n<text x=\'403\' y=\'88\' class=\'textm\'>0</text>\n  <rect x=\'413\' y=\'77\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--input-light, #7CA3A5)\'/>  <polygon points=\'413,77 503,77 593,77 593,91 413,91\' stroke=\'none\' fill=\'var(--input-medium, #5A8183)\'/>\n<rect x=\'413\' y=\'80\' 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=\'88\'>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=\'598\' y=\'77\' width=\'682\' height=\'14\' class=\'background\'/>\n<rect x=\'601\' y=\'77\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--input-medium, #5A8183)\'/>\n</g>\n<g><title>Output 50%, 41B, Rows 50%, 2</title>\n<rect x=\'395\' y=\'98\' width=\'200\' height=\'14\' class=\'background\'/>\n<use href=\'#icon_output\' transform=\'translate(395 98) scale(0.0325 0.0325)\' fill=\'var(--output-light, #6F93C3)\'/>\n<text x=\'403\' y=\'109\' class=\'textm\'>1</text>\n  <rect x=\'413\' y=\'98\' width=\'180\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-light, #6F93C3)\'/>  <polygon points=\'413,98 503,98 593,98 593,112 413,112\' stroke=\'none\' fill=\'var(--output-medium, #5781B9)\'/>\n<rect x=\'413\' y=\'101\' 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=\'109\'>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=\'598\' y=\'98\' width=\'682\' height=\'14\' class=\'background\'/>\n<rect x=\'601\' y=\'98\' width=\'0\' height=\'14\' stroke-width=\'0\' fill=\'var(--output-medium, #5781B9)\'/>\n</g>\n</g>\n\n<line x1=\'600\' y1=\'0\' x2=\'600\' y2=\'162\' stroke-width=\'1\' stroke=\'var(--stage-grid, #B2B2B2)\' stroke-dasharray=\'1,2\'/>\n<text x=\'602\' y=\'11\' class=\'texts\'>0:00</text>\n<text x=\'303\' y=\'11\' class=\'texts\'>Operators</text>\n<text x=\'397\' y=\'11\' class=\'texts\'>Stages</text>\n<text x=\'390\' y=\'11\' class=\'texte\'>Tasks</text>\n<text x=\'390\' y=\'22\' class=\'texte\'>2</text>\n<g><title>Ingress 88B, Rows 2, Width 44B, Avg 88B/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\'>88B</text>\n</g>\n<g><title>CPU Usage 455us, 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\'>455us</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 1.60</title>\n<path d=\'M598,26c0,0,0,-13,0,-13c0,0,0,11,0,11c0,0,0,2,0,2z\' stroke-width=\'1\' stroke=\'var(--cpu-medium, #A36D7B)\' fill=\'var(--cpu-light, #B78C98)\' />\n</g>\n\n</svg>\n"
  }
}

2025-11-10 09:36:19,874 - DEBUG - root - validate_timestamp_posix_result: columns {
  name: "Fruit"
  type {
    type_id: STRING
  }
}
columns {
  name: "Price"
  type {
    type_id: INT32
  }
}
columns {
  name: "Time"
  type {
    type_id: TIMESTAMP
  }
}
columns {
  name: "Weight"
  type {
    type_id: INT32
  }
}
rows {
  items {
    bytes_value: "Banana"
  }
  items {
    int32_value: 3
  }
  items {
    uint64_value: 1666197647000000
  }
  items {
    int32_value: 100
  }
}
rows {
  items {
    bytes_value: "Apple"
  }
  items {
    int32_value: 2
  }
  items {
    uint64_value: 1666197707000000
  }
  items {
    int32_value: 22
  }
}

2025-11-10 09:36:19,876 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-10 09:44:10,561 - DEBUG - ya.test - _verify_test: Verifying [test_format_setting.TestS3.test_timestamp_simple_posix[v2-common/simple_posix/test.csv-csv_with_names] in ydb/tests/fq/s3] canonical results
2025-11-10 09:44:10,563 - DEBUG - ya.test - verify: Test test_format_setting.TestS3.test_timestamp_simple_posix[v2-common/simple_posix/test.csv-csv_with_names] status: good
