Ceph » rgw

This is for 17.2.1
Run: http://pulpito.front.sepia.ceph.com/yuriw-2022-06-11_14:50:16-smoke-quincy-release-distro-default-smithi/
Jobs: '6874420', '6874421'
Logs: http://qa-proxy.ceph.com/teuthology/yuriw-2022-06-11_14:50:16-smoke-quincy-release-distro-default-smithi/6874420/teuthology.log

2022-06-11T15:10:59.648 INFO:teuthology.orchestra.run.smithi171.stderr:======================================================================
2022-06-11T15:10:59.649 INFO:teuthology.orchestra.run.smithi171.stderr:ERROR: s3tests_boto3.functional.test_s3.test_bucket_policy_put_obj_s3_noenc
2022-06-11T15:10:59.649 INFO:teuthology.orchestra.run.smithi171.stderr:----------------------------------------------------------------------
2022-06-11T15:10:59.649 INFO:teuthology.orchestra.run.smithi171.stderr:Traceback (most recent call last):
2022-06-11T15:10:59.649 INFO:teuthology.orchestra.run.smithi171.stderr:  File "/home/ubuntu/cephtest/s3-tests/virtualenv/lib/python3.8/site-packages/nose/case.py", line 198, in runTest
2022-06-11T15:10:59.650 INFO:teuthology.orchestra.run.smithi171.stderr:    self.test(*self.arg)
2022-06-11T15:10:59.650 INFO:teuthology.orchestra.run.smithi171.stderr:  File "/home/ubuntu/cephtest/s3-tests/s3tests_boto3/functional/test_s3.py", line 12949, in test_bucket_policy_put_obj_s3_noenc
2022-06-11T15:10:59.650 INFO:teuthology.orchestra.run.smithi171.stderr:    response['ResponseMetadata']['HTTPHeaders']['x-amz-server-side-encryption']
2022-06-11T15:10:59.650 INFO:teuthology.orchestra.run.smithi171.stderr:KeyError: 'x-amz-server-side-encryption'
2022-06-11T15:10:59.651 INFO:teuthology.orchestra.run.smithi171.stderr:-------------------- >> begin captured logging << --------------------
2022-06-11T15:10:59.651 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f8c7ab7e5e0>
2022-06-11T15:10:59.651 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f8c7ac00a60>
2022-06-11T15:10:59.651 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f8c78394d30>
2022-06-11T15:10:59.651 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f8c7ac00820>
2022-06-11T15:10:59.652 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Setting s3 timeout as (60, 60)
2022-06-11T15:10:59.652 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.client: DEBUG: Registering retry handlers for service: s3
2022-06-11T15:10:59.652 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.CreateBucket: calling handler <function validate_bucket_name at 0x7f8c7ab12ee0>
2022-06-11T15:10:59.652 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3RegionRedirector.redirect_from_cache of <botocore.utils.S3RegionRedirector object at 0x7f8c7a1fbca0>>
2022-06-11T15:10:59.653 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.CreateBucket: calling handler <bound method S3ArnParamHandler.handle_arn of <botocore.utils.S3ArnParamHandler object at 0x7f8c7a1fb7f0>>
2022-06-11T15:10:59.653 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.CreateBucket: calling handler <function generate_idempotent_uuid at 0x7f8c7ab12d30>
2022-06-11T15:10:59.653 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.CreateBucket: calling handler <function add_expect_header at 0x7f8c7ab17280>
2022-06-11T15:10:59.653 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.CreateBucket: calling handler <bound method S3RegionRedirector.set_request_url of <botocore.utils.S3RegionRedirector object at 0x7f8c7a1fbca0>>
2022-06-11T15:10:59.653 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.CreateBucket: calling handler <function add_recursion_detection_header at 0x7f8c7ab129d0>
2022-06-11T15:10:59.654 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.CreateBucket: calling handler <function inject_api_version_header_if_needed at 0x7f8c7ab185e0>
2022-06-11T15:10:59.654 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Making request for OperationModel(name=CreateBucket) with params: {'url_path': '/test-client.0-vnejf4zud9iyt1j-447', 'query_string': {}, 'method': 'PUT', 'headers': {'User-Agent': 'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7'}, 'body': b'', 'url': 'http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447', 'context': {'client_region': 'us-east-1', 'client_config': <botocore.config.Config object at 0x7f8c7a047100>, 'has_streaming_input': False, 'auth_type': None, 'signing': {'bucket': 'test-client.0-vnejf4zud9iyt1j-447'}}}
2022-06-11T15:10:59.654 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.CreateBucket: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f8c7a047c70>>
2022-06-11T15:10:59.654 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.CreateBucket: calling handler <bound method S3EndpointSetter.set_signer of <botocore.utils.S3EndpointSetter object at 0x7f8c7a1fb430>>
2022-06-11T15:10:59.655 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.CreateBucket: calling handler <function set_operation_specific_signer at 0x7f8c7ab12c10>
2022-06-11T15:10:59.655 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-sign.s3.CreateBucket: calling handler <bound method S3EndpointSetter.set_endpoint of <botocore.utils.S3EndpointSetter object at 0x7f8c7a1fb430>>
2022-06-11T15:10:59.655 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.utils: DEBUG: Using S3 path style addressing.
2022-06-11T15:10:59.655 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: Calculating signature using v4 auth.
2022-06-11T15:10:59.656 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: CanonicalRequest:
2022-06-11T15:10:59.656 INFO:teuthology.orchestra.run.smithi171.stderr:PUT
2022-06-11T15:10:59.656 INFO:teuthology.orchestra.run.smithi171.stderr:/test-client.0-vnejf4zud9iyt1j-447
2022-06-11T15:10:59.656 INFO:teuthology.orchestra.run.smithi171.stderr:
2022-06-11T15:10:59.656 INFO:teuthology.orchestra.run.smithi171.stderr:host:smithi171.front.sepia.ceph.com
2022-06-11T15:10:59.657 INFO:teuthology.orchestra.run.smithi171.stderr:x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2022-06-11T15:10:59.657 INFO:teuthology.orchestra.run.smithi171.stderr:x-amz-date:20220611T150828Z
2022-06-11T15:10:59.657 INFO:teuthology.orchestra.run.smithi171.stderr:
2022-06-11T15:10:59.657 INFO:teuthology.orchestra.run.smithi171.stderr:host;x-amz-content-sha256;x-amz-date
2022-06-11T15:10:59.658 INFO:teuthology.orchestra.run.smithi171.stderr:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2022-06-11T15:10:59.658 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: StringToSign:
2022-06-11T15:10:59.658 INFO:teuthology.orchestra.run.smithi171.stderr:AWS4-HMAC-SHA256
2022-06-11T15:10:59.658 INFO:teuthology.orchestra.run.smithi171.stderr:20220611T150828Z
2022-06-11T15:10:59.658 INFO:teuthology.orchestra.run.smithi171.stderr:20220611/us-east-1/s3/aws4_request
2022-06-11T15:10:59.659 INFO:teuthology.orchestra.run.smithi171.stderr:5e35fa32708cc3d0a053322d143c8aa5d500a9e5fd8d59f37547e6ae2c795350
2022-06-11T15:10:59.659 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: Signature:
2022-06-11T15:10:59.659 INFO:teuthology.orchestra.run.smithi171.stderr:43c63036fde42948e9bf3b5a2715ad5fbdf040ac2780dddd16d5fe483f20ed5d
2022-06-11T15:10:59.659 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.CreateBucket: calling handler <function add_retry_headers at 0x7f8c7ab18ca0>
2022-06-11T15:10:59.660 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447, headers={'User-Agent': b'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7', 'X-Amz-Date': b'20220611T150828Z', 'X-Amz-Content-SHA256': b'e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855', 'Authorization': b'AWS4-HMAC-SHA256 Credential=FZJPBKJANWXIDPAAZBHX/20220611/us-east-1/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=43c63036fde42948e9bf3b5a2715ad5fbdf040ac2780dddd16d5fe483f20ed5d', 'amz-sdk-invocation-id': b'1a3bf66f-184d-432b-bf98-e5cdb93d131a', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2022-06-11T15:10:59.660 INFO:teuthology.orchestra.run.smithi171.stderr:urllib3.connectionpool: DEBUG: Starting new HTTP connection (1): smithi171.front.sepia.ceph.com:80
2022-06-11T15:10:59.660 INFO:teuthology.orchestra.run.smithi171.stderr:urllib3.connectionpool: DEBUG: http://smithi171.front.sepia.ceph.com:80 "PUT /test-client.0-vnejf4zud9iyt1j-447 HTTP/1.1" 200 0
2022-06-11T15:10:59.660 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response headers: {'x-amz-request-id': 'tx000003642e011e7feb628-0062a4afec-1172-default', 'Content-Length': '0', 'Date': 'Sat, 11 Jun 2022 15:08:28 GMT', 'Connection': 'Keep-Alive'}
2022-06-11T15:10:59.661 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response body:
2022-06-11T15:10:59.661 INFO:teuthology.orchestra.run.smithi171.stderr:b''
2022-06-11T15:10:59.661 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.CreateBucket: calling handler <botocore.retryhandler.RetryHandler object at 0x7f8c7a1fbd90>
2022-06-11T15:10:59.661 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.retryhandler: DEBUG: No retry needed.
2022-06-11T15:10:59.661 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.CreateBucket: calling handler <bound method S3RegionRedirector.redirect_from_error of <botocore.utils.S3RegionRedirector object at 0x7f8c7a1fbca0>>
2022-06-11T15:10:59.662 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-service-name: calling handler <function handle_service_name_alias at 0x7f8c7ab7e5e0>
2022-06-11T15:10:59.662 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function add_generate_presigned_post at 0x7f8c7ac00a60>
2022-06-11T15:10:59.662 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function lazy_call.<locals>._handler at 0x7f8c78394d30>
2022-06-11T15:10:59.662 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event creating-client-class.s3: calling handler <function add_generate_presigned_url at 0x7f8c7ac00820>
2022-06-11T15:10:59.663 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Setting s3 timeout as (60, 60)
2022-06-11T15:10:59.663 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.client: DEBUG: Registering retry handlers for service: s3
2022-06-11T15:10:59.663 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutBucketPolicy: calling handler <function validate_bucket_name at 0x7f8c7ab12ee0>
2022-06-11T15:10:59.663 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutBucketPolicy: calling handler <bound method S3RegionRedirector.redirect_from_cache of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.663 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutBucketPolicy: calling handler <bound method S3ArnParamHandler.handle_arn of <botocore.utils.S3ArnParamHandler object at 0x7f8c7a2cb160>>
2022-06-11T15:10:59.664 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutBucketPolicy: calling handler <function generate_idempotent_uuid at 0x7f8c7ab12d30>
2022-06-11T15:10:59.664 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutBucketPolicy: calling handler <function add_expect_header at 0x7f8c7ab17280>
2022-06-11T15:10:59.664 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutBucketPolicy: calling handler <bound method S3RegionRedirector.set_request_url of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.664 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutBucketPolicy: calling handler <function add_recursion_detection_header at 0x7f8c7ab129d0>
2022-06-11T15:10:59.665 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutBucketPolicy: calling handler <function inject_api_version_header_if_needed at 0x7f8c7ab185e0>
2022-06-11T15:10:59.665 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Making request for OperationModel(name=PutBucketPolicy) with params: {'url_path': '/test-client.0-vnejf4zud9iyt1j-447?policy', 'query_string': {}, 'method': 'PUT', 'headers': {'User-Agent': 'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7', 'Content-MD5': 'pAac63JOnaHlHnPqo3MKjg=='}, 'body': b'{"Version": "2012-10-17", "Statement": [{"Action": "s3:PutObject", "Principal": {"AWS": "*"}, "Effect": "Deny", "Resource": "arn:aws:s3:::test-client.0-vnejf4zud9iyt1j-447/*", "Condition": {"StringNotEquals": {"s3:x-amz-server-side-encryption": "AES256"}}}, {"Action": "s3:PutObject", "Principal": {"AWS": "*"}, "Effect": "Deny", "Resource": "arn:aws:s3:::test-client.0-vnejf4zud9iyt1j-447/*", "Condition": {"Null": {"s3:x-amz-server-side-encryption": "true"}}}]}', 'url': 'http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447?policy', 'context': {'client_region': 'us-east-1', 'client_config': <botocore.config.Config object at 0x7f8c79c6c430>, 'has_streaming_input': False, 'auth_type': None, 'signing': {'bucket': 'test-client.0-vnejf4zud9iyt1j-447'}, 'checksum': {'request_algorithm': 'conditional-md5'}}}
2022-06-11T15:10:59.665 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.PutBucketPolicy: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f8c79c6ca00>>
2022-06-11T15:10:59.665 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.PutBucketPolicy: calling handler <bound method S3EndpointSetter.set_signer of <botocore.utils.S3EndpointSetter object at 0x7f8c7a2cb730>>
2022-06-11T15:10:59.666 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.PutBucketPolicy: calling handler <function set_operation_specific_signer at 0x7f8c7ab12c10>
2022-06-11T15:10:59.666 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-sign.s3.PutBucketPolicy: calling handler <bound method S3EndpointSetter.set_endpoint of <botocore.utils.S3EndpointSetter object at 0x7f8c7a2cb730>>
2022-06-11T15:10:59.666 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.utils: DEBUG: Using S3 path style addressing.
2022-06-11T15:10:59.666 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: Calculating signature using hmacv1 auth.
2022-06-11T15:10:59.667 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: HTTP request method: PUT
2022-06-11T15:10:59.667 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: StringToSign:
2022-06-11T15:10:59.667 INFO:teuthology.orchestra.run.smithi171.stderr:PUT
2022-06-11T15:10:59.667 INFO:teuthology.orchestra.run.smithi171.stderr:pAac63JOnaHlHnPqo3MKjg==
2022-06-11T15:10:59.667 INFO:teuthology.orchestra.run.smithi171.stderr:
2022-06-11T15:10:59.668 INFO:teuthology.orchestra.run.smithi171.stderr:Sat, 11 Jun 2022 15:08:28 GMT
2022-06-11T15:10:59.668 INFO:teuthology.orchestra.run.smithi171.stderr:/test-client.0-vnejf4zud9iyt1j-447?policy
2022-06-11T15:10:59.668 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.PutBucketPolicy: calling handler <function add_retry_headers at 0x7f8c7ab18ca0>
2022-06-11T15:10:59.668 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447?policy, headers={'User-Agent': b'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7', 'Content-MD5': b'pAac63JOnaHlHnPqo3MKjg==', 'Date': b'Sat, 11 Jun 2022 15:08:28 GMT', 'Authorization': b'AWS FZJPBKJANWXIDPAAZBHX:WBAsZTgsg4f+o3s5ScirufX/TR0=', 'amz-sdk-invocation-id': b'4c61720d-6ff9-457c-9b57-0b4d71397043', 'amz-sdk-request': b'attempt=1', 'Content-Length': '463'}>
2022-06-11T15:10:59.669 INFO:teuthology.orchestra.run.smithi171.stderr:urllib3.connectionpool: DEBUG: Starting new HTTP connection (1): smithi171.front.sepia.ceph.com:80
2022-06-11T15:10:59.669 INFO:teuthology.orchestra.run.smithi171.stderr:urllib3.connectionpool: DEBUG: http://smithi171.front.sepia.ceph.com:80 "PUT /test-client.0-vnejf4zud9iyt1j-447?policy HTTP/1.1" 204 0
2022-06-11T15:10:59.669 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response headers: {'x-amz-request-id': 'tx000009fa170344117bbf5-0062a4afec-1172-default', 'Date': 'Sat, 11 Jun 2022 15:08:28 GMT', 'Connection': 'Keep-Alive'}
2022-06-11T15:10:59.669 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response body:
2022-06-11T15:10:59.669 INFO:teuthology.orchestra.run.smithi171.stderr:b''
2022-06-11T15:10:59.670 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.PutBucketPolicy: calling handler <botocore.retryhandler.RetryHandler object at 0x7f8c7a2cbf10>
2022-06-11T15:10:59.670 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.retryhandler: DEBUG: No retry needed.
2022-06-11T15:10:59.670 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.PutBucketPolicy: calling handler <bound method S3RegionRedirector.redirect_from_error of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.670 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <function validate_ascii_metadata at 0x7f8c7ab17b80>
2022-06-11T15:10:59.671 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <function sse_md5 at 0x7f8c7ab12f70>
2022-06-11T15:10:59.671 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <function convert_body_to_file_like_object at 0x7f8c7ab184c0>
2022-06-11T15:10:59.671 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <function validate_bucket_name at 0x7f8c7ab12ee0>
2022-06-11T15:10:59.671 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <bound method S3RegionRedirector.redirect_from_cache of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.671 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <bound method S3ArnParamHandler.handle_arn of <botocore.utils.S3ArnParamHandler object at 0x7f8c7a2cb160>>
2022-06-11T15:10:59.672 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-parameter-build.s3.PutObject: calling handler <function generate_idempotent_uuid at 0x7f8c7ab12d30>
2022-06-11T15:10:59.672 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutObject: calling handler <function conditionally_calculate_md5 at 0x7f8c7ac59940>
2022-06-11T15:10:59.672 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutObject: calling handler <function add_expect_header at 0x7f8c7ab17280>
2022-06-11T15:10:59.672 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutObject: calling handler <bound method S3RegionRedirector.set_request_url of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.673 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutObject: calling handler <function add_recursion_detection_header at 0x7f8c7ab129d0>
2022-06-11T15:10:59.673 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-call.s3.PutObject: calling handler <function inject_api_version_header_if_needed at 0x7f8c7ab185e0>
2022-06-11T15:10:59.673 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Making request for OperationModel(name=PutObject) with params: {'url_path': '/test-client.0-vnejf4zud9iyt1j-447/testobj', 'query_string': {}, 'method': 'PUT', 'headers': {'x-amz-server-side-encryption': 'AES256', 'User-Agent': 'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7', 'Content-MD5': '1B2M2Y8AsgTpgAmY7PhCfg=='}, 'body': b'', 'url': 'http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447/testobj', 'context': {'client_region': 'us-east-1', 'client_config': <botocore.config.Config object at 0x7f8c79c6c430>, 'has_streaming_input': True, 'auth_type': None, 'signing': {'bucket': 'test-client.0-vnejf4zud9iyt1j-447'}}}
2022-06-11T15:10:59.673 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.PutObject: calling handler <bound method RequestSigner.handler of <botocore.signers.RequestSigner object at 0x7f8c79c6ca00>>
2022-06-11T15:10:59.673 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.PutObject: calling handler <bound method S3EndpointSetter.set_signer of <botocore.utils.S3EndpointSetter object at 0x7f8c7a2cb730>>
2022-06-11T15:10:59.674 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event choose-signer.s3.PutObject: calling handler <function set_operation_specific_signer at 0x7f8c7ab12c10>
2022-06-11T15:10:59.674 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event before-sign.s3.PutObject: calling handler <bound method S3EndpointSetter.set_endpoint of <botocore.utils.S3EndpointSetter object at 0x7f8c7a2cb730>>
2022-06-11T15:10:59.674 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: Calculating signature using hmacv1 auth.
2022-06-11T15:10:59.674 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: HTTP request method: PUT
2022-06-11T15:10:59.675 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.auth: DEBUG: StringToSign:
2022-06-11T15:10:59.675 INFO:teuthology.orchestra.run.smithi171.stderr:PUT
2022-06-11T15:10:59.675 INFO:teuthology.orchestra.run.smithi171.stderr:1B2M2Y8AsgTpgAmY7PhCfg==
2022-06-11T15:10:59.676 INFO:teuthology.orchestra.run.smithi171.stderr:
2022-06-11T15:10:59.676 INFO:teuthology.orchestra.run.smithi171.stderr:Sat, 11 Jun 2022 15:08:28 GMT
2022-06-11T15:10:59.676 INFO:teuthology.orchestra.run.smithi171.stderr:x-amz-server-side-encryption:AES256
2022-06-11T15:10:59.676 INFO:teuthology.orchestra.run.smithi171.stderr:/test-client.0-vnejf4zud9iyt1j-447/testobj
2022-06-11T15:10:59.676 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event request-created.s3.PutObject: calling handler <function add_retry_headers at 0x7f8c7ab18ca0>
2022-06-11T15:10:59.677 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.endpoint: DEBUG: Sending http request: <AWSPreparedRequest stream_output=False, method=PUT, url=http://smithi171.front.sepia.ceph.com:80/test-client.0-vnejf4zud9iyt1j-447/testobj, headers={'x-amz-server-side-encryption': b'AES256', 'User-Agent': b'Boto3/1.24.7 Python/3.8.10 Linux/5.4.0-117-generic Botocore/1.27.7', 'Content-MD5': b'1B2M2Y8AsgTpgAmY7PhCfg==', 'Date': b'Sat, 11 Jun 2022 15:08:28 GMT', 'Authorization': b'AWS FZJPBKJANWXIDPAAZBHX:0sfWunMUomEtL0ZeQbAJ0Xbgnfs=', 'amz-sdk-invocation-id': b'5ccff5dc-937c-48de-a857-c1a023f1aa58', 'amz-sdk-request': b'attempt=1', 'Content-Length': '0'}>
2022-06-11T15:10:59.677 INFO:teuthology.orchestra.run.smithi171.stderr:urllib3.connectionpool: DEBUG: http://smithi171.front.sepia.ceph.com:80 "PUT /test-client.0-vnejf4zud9iyt1j-447/testobj HTTP/1.1" 200 0
2022-06-11T15:10:59.677 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response headers: {'Content-Length': '0', 'ETag': '"d41d8cd98f00b204e9800998ecf8427e"', 'Accept-Ranges': 'bytes', 'x-amz-request-id': 'tx00000a73b52aeb277eaaa-0062a4afec-1172-default', 'Date': 'Sat, 11 Jun 2022 15:08:28 GMT', 'Connection': 'Keep-Alive'}
2022-06-11T15:10:59.678 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.parsers: DEBUG: Response body:
2022-06-11T15:10:59.678 INFO:teuthology.orchestra.run.smithi171.stderr:b''
2022-06-11T15:10:59.678 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.PutObject: calling handler <botocore.retryhandler.RetryHandler object at 0x7f8c7a2cbf10>
2022-06-11T15:10:59.678 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.retryhandler: DEBUG: No retry needed.
2022-06-11T15:10:59.678 INFO:teuthology.orchestra.run.smithi171.stderr:botocore.hooks: DEBUG: Event needs-retry.s3.PutObject: calling handler <bound method S3RegionRedirector.redirect_from_error of <botocore.utils.S3RegionRedirector object at 0x7f8c7a2cb760>>
2022-06-11T15:10:59.679 INFO:teuthology.orchestra.run.smithi171.stderr:--------------------- >> end captured logging << ---------------------