Skip to content

Instantly share code, notes, and snippets.

@alexcos78

alexcos78/gist:7d3eb8e960f0906b6be0d784afefc921

Created October 27, 2022 09:42
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save alexcos78/7d3eb8e960f0906b6be0d784afefc921 to your computer and use it in GitHub Desktop.
Save alexcos78/7d3eb8e960f0906b6be0d784afefc921 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
2022-10-27T10:39:41.809+0200 7fe016a53700 20 CONTENT_LENGTH=56
2022-10-27T10:39:41.809+0200 7fe016a53700 20 CONTENT_TYPE=application/x-www-form-urlencoded; charset=utf-8
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_ACCEPT_ENCODING=identity
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_AMZ_SDK_INVOCATION_ID=48666cb7-31e4-482f-86a2-3198b3be6360
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_AMZ_SDK_REQUEST=attempt=1
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_AUTHORIZATION=AWS4-HMAC-SHA256 Credential=TESTER/20221027//iam/aws4_request, SignedHeaders=content-type;host;x-amz-date, Signature=d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_HOST=ceph-mon01-tb.cloud.cnaf.infn.it:7480
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_USER_AGENT=Boto3/1.23.10 Python/3.6.9 Linux/4.15.0-193-generic Botocore/1.26.10
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_VERSION=1.1
2022-10-27T10:39:41.809+0200 7fe016a53700 20 HTTP_X_AMZ_DATE=20221027T083941Z
2022-10-27T10:39:41.809+0200 7fe016a53700 20 REMOTE_ADDR=131.154.97.209
2022-10-27T10:39:41.809+0200 7fe016a53700 20 REQUEST_METHOD=POST
2022-10-27T10:39:41.809+0200 7fe016a53700 20 REQUEST_URI=/
2022-10-27T10:39:41.809+0200 7fe016a53700 20 SCRIPT_URI=/
2022-10-27T10:39:41.809+0200 7fe016a53700 20 SERVER_PORT=7480
2022-10-27T10:39:41.809+0200 7fe016a53700 1 ====== starting new request req=0x7fe016a4ab90 =====
2022-10-27T10:39:41.809+0200 7fe016a53700 2 req 6146865621466741246 0.000000000s initializing for trans_id = tx00000554e0db71995f9fe-00635a43cd-6b044ce-default
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s rgw api priority: s3=8 s3website=7
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s host=ceph-mon01-tb.cloud.cnaf.infn.it
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s final domain/bucket subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0 s->info.domain= s->info.request_uri=/
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s meta>> HTTP_X_AMZ_DATE
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s x>> x-amz-date:20221027T083941Z
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s get_handler handler=26RGWHandler_REST_Service_S3
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s handler=26RGWHandler_REST_Service_S3
2022-10-27T10:39:41.809+0200 7fe016a53700 2 req 6146865621466741246 0.000000000s getting op 4
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s Content of POST: Action=GetRole&Version=2010-05-08&RoleName=S3Accesswebid
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s Content of POST: Action=GetRole&Version=2010-05-08&RoleName=S3Accesswebid
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s iam:get_role op=10RGWGetRole
2022-10-27T10:39:41.809+0200 7fe016a53700 2 req 6146865621466741246 0.000000000s iam:get_role verifying requester
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::StrategyRegistry::s3_main_strategy_t: trying rgw::auth::s3::AWSAuthStrategy
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::S3AnonymousEngine
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::S3AnonymousEngine denied with reason=-1
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::STSAuthStrategy
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::STSAuthStrategy: trying rgw::auth::s3::STSEngine
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s v4 signature format = d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s v4 credential format = TESTER/20221027//iam/aws4_request
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s access key id = TESTER
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s credential scope = 20221027//iam/aws4_request
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical headers format = content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s payload request hash = d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical request = POST
/
content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
content-type;host;x-amz-date
d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical request hash = 4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s string to sign = AWS4-HMAC-SHA256
20221027T083941Z
20221027//iam/aws4_request
4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::STSEngine denied with reason=-13
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::STSAuthStrategy denied with reason=-13
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::AWSv2ExternalAuthStrategy
2022-10-27T10:39:41.809+0200 7fe016a53700 20 req 6146865621466741246 0.000000000s iam:get_role rgw::auth::s3::AWSv2ExternalAuthStrategy: trying rgw::auth::keystone::EC2Engine
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s v4 signature format = d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s v4 credential format = TESTER/20221027//iam/aws4_request
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s access key id = TESTER
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s credential scope = 20221027//iam/aws4_request
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical headers format = content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s payload request hash = d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical request = POST
/
content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
content-type;host;x-amz-date
d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s canonical request hash = 4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:41.809+0200 7fe016a53700 10 req 6146865621466741246 0.000000000s string to sign = AWS4-HMAC-SHA256
20221027T083941Z
20221027//iam/aws4_request
4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:41.809+0200 7fe016a53700 0 req 6146865621466741246 0.000000000s iam:get_role No stored secret string, cache miss
2022-10-27T10:39:41.809+0200 7fe016a53700 20 sending request to https://tb-cloud-api-int.cr.cnaf.infn.it:5000/v3/auth/tokens
2022-10-27T10:39:41.809+0200 7fe016a53700 20 register_request mgr=0x56536275fd40 req_data->id=56, curl_handle=0x5653635799e0
2022-10-27T10:39:41.809+0200 7fe03eaa3700 20 link_request req_data=0x5653648970e0 req_data->id=56, curl_handle=0x5653635799e0
2022-10-27T10:39:42.192+0200 7fe016a53700 20 sending request to https://tb-cloud-api-int.cr.cnaf.infn.it:5000/v3/s3tokens
2022-10-27T10:39:42.193+0200 7fe016a53700 20 register_request mgr=0x56536275fd40 req_data->id=57, curl_handle=0x5653635799e0
2022-10-27T10:39:42.193+0200 7fe03eaa3700 20 link_request req_data=0x5653648970e0 req_data->id=57, curl_handle=0x5653635799e0
2022-10-27T10:39:42.221+0200 7fe016a53700 2 req 6146865621466741246 0.412006199s iam:get_role s3 keystone: token validation ERROR: {"error":{"code":404,"message":"Could not find credential: 25a1f47c1841dce0ec7f232d32accd7d5fba23a07988e0c0763f444bd86a9548.","title":"Not Found"}}
2022-10-27T10:39:42.221+0200 7fe016a53700 20 req 6146865621466741246 0.412006199s iam:get_role rgw::auth::keystone::EC2Engine denied with reason=-2
2022-10-27T10:39:42.221+0200 7fe016a53700 20 req 6146865621466741246 0.412006199s iam:get_role rgw::auth::s3::AWSv2ExternalAuthStrategy denied with reason=-2
2022-10-27T10:39:42.221+0200 7fe016a53700 20 req 6146865621466741246 0.412006199s iam:get_role rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::LocalEngine
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s v4 signature format = d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s v4 credential format = TESTER/20221027//iam/aws4_request
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s access key id = TESTER
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s credential scope = 20221027//iam/aws4_request
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s canonical headers format = content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s payload request hash = d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s canonical request = POST
/
content-type:application/x-www-form-urlencoded; charset=utf-8
host:ceph-mon01-tb.cloud.cnaf.infn.it:7480
x-amz-date:20221027T083941Z
content-type;host;x-amz-date
d8ad1fb25ed7c1125b08b365e75342f89d8574bb1b2f0101210d815156f85333
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s canonical request hash = 4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s string to sign = AWS4-HMAC-SHA256
20221027T083941Z
20221027//iam/aws4_request
4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:42.221+0200 7fe016a53700 20 req 6146865621466741246 0.412006199s iam:get_role get_system_obj_state: rctx=0x7fe016a49148 obj=default.rgw.meta:users.keys:TESTER state=0x56536445dde0 s->prefetch_data=0
2022-10-27T10:39:42.221+0200 7fe016a53700 10 req 6146865621466741246 0.412006199s iam:get_role cache get: name=default.rgw.meta+users.keys+TESTER : type miss (requested=0x6, cached=0x3)
2022-10-27T10:39:42.221+0200 7fe016a53700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11906 11.2 11:6b213cc5:users.keys::TESTER:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x56536469cc00 con 0x5653635c7000
2022-10-27T10:39:42.222+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1983 ==== osd_op_reply(11906 TESTER [getxattrs out=4b,stat out=16b] v0'0 uv109 ondisk = 0) v8 ==== 192+0+20 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache put: name=default.rgw.meta+users.keys+TESTER info.flags=0x6
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role moving default.rgw.meta+users.keys+TESTER to cache LRU end
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache get: name=default.rgw.meta+users.keys+TESTER : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role get_system_obj_state: rctx=0x7fe016a49148 obj=default.rgw.meta:users.uid:TESTER state=0x5653644249a0 s->prefetch_data=0
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache get: name=default.rgw.meta+users.uid+TESTER : type miss (requested=0x16, cached=0x7)
2022-10-27T10:39:42.222+0200 7fe016a53700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11907 11.0 11:142c659c:users.uid::TESTER:head [call version.read in=11b,getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x5653646e8400 con 0x5653635c7000
2022-10-27T10:39:42.222+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1984 ==== osd_op_reply(11907 TESTER [call out=48b,getxattrs out=75b,stat out=16b] v0'0 uv43 ondisk = 0) v8 ==== 234+0+139 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache put: name=default.rgw.meta+users.uid+TESTER info.flags=0x16
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role moving default.rgw.meta+users.uid+TESTER to cache LRU end
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role updating xattr: name=ceph.objclass.version bl.length()=42
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache get: name=default.rgw.meta+users.uid+TESTER : hit (requested=0x11, cached=0x17)
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role chain_cache_entry: cache_locator=default.rgw.meta+users.uid+TESTER
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s date_k = 0c09910a6d1a529c2071e10947c39d7e0896c7a07aa5678c6c0bca15c092052a
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s region_k = bc9b793a8630d850965e17cf17a7b060f24297d068bbc33f6fb35a7cd24c5d26
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s service_k = ed2628cfe31af130dfdefb8ed41607732f12910edffda4b503a94d30e6f084cd
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s signing_k = 8daebe6f34f48ac97853ac7c31e3fc8f6c4c1f276baa28cf43bf28f1ced1d04c
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s generated signature = d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:42.222+0200 7fe016a53700 15 req 6146865621466741246 0.413006246s iam:get_role string_to_sign=AWS4-HMAC-SHA256
20221027T083941Z
20221027//iam/aws4_request
4def23ff2195ca6c236720200efbf9a6249c3e45fc56b6fa509999f2d9ab3d5d
2022-10-27T10:39:42.222+0200 7fe016a53700 15 req 6146865621466741246 0.413006246s iam:get_role server signature=d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:42.222+0200 7fe016a53700 15 req 6146865621466741246 0.413006246s iam:get_role client signature=d865db49881cf486a424292e4a36adbc4e1c7e98eaeaacbd0c6ddfe6995c1e4b
2022-10-27T10:39:42.222+0200 7fe016a53700 15 req 6146865621466741246 0.413006246s iam:get_role compare=0
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role rgw::auth::s3::LocalEngine granted access
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role rgw::auth::s3::AWSAuthStrategy granted access
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role normalizing buckets and tenants
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s s->object=<NULL> s->bucket=
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role init permissions
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role get_system_obj_state: rctx=0x7fe016a490d8 obj=default.rgw.meta:users.uid:TESTER state=0x56536445dde0 s->prefetch_data=0
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache get: name=default.rgw.meta+users.uid+TESTER : hit (requested=0x6, cached=0x17)
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role Read xattr: user.rgw.idtag
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s iam:get_role cache get: name=default.rgw.meta+users.uid+TESTER : hit (requested=0x3, cached=0x17)
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role recalculating target
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role reading permissions
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role init op
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role verifying op mask
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s iam:get_role required_mask= 0 user.op_mask=7
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role verifying op permissions
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role verifying op params
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role pre-executing
2022-10-27T10:39:42.222+0200 7fe016a53700 2 req 6146865621466741246 0.413006246s iam:get_role executing
2022-10-27T10:39:42.222+0200 7fe016a53700 20 req 6146865621466741246 0.413006246s get_system_obj_state: rctx=0x7fe016a49b50 obj=default.rgw.meta:roles:role_names.S3Accesswebid state=0x5653644249a0 s->prefetch_data=0
2022-10-27T10:39:42.222+0200 7fe016a53700 10 req 6146865621466741246 0.413006246s cache get: name=default.rgw.meta+roles+role_names.S3Accesswebid : type miss (requested=0x6, cached=0x3)
2022-10-27T10:39:42.222+0200 7fe016a53700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11908 11.0 11:0d391158:roles::role_names.S3Accesswebid:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x565364788000 con 0x5653635c7000
2022-10-27T10:39:42.223+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1985 ==== osd_op_reply(11908 role_names.S3Accesswebid [getxattrs out=4b,stat out=16b] v0'0 uv68 ondisk = 0) v8 ==== 210+0+20 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.223+0200 7fe016a53700 10 req 6146865621466741246 0.414006233s cache put: name=default.rgw.meta+roles+role_names.S3Accesswebid info.flags=0x6
2022-10-27T10:39:42.223+0200 7fe016a53700 10 req 6146865621466741246 0.414006233s moving default.rgw.meta+roles+role_names.S3Accesswebid to cache LRU end
2022-10-27T10:39:42.223+0200 7fe016a53700 20 req 6146865621466741246 0.414006233s get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.223+0200 7fe016a53700 10 req 6146865621466741246 0.414006233s cache get: name=default.rgw.meta+roles+role_names.S3Accesswebid : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.223+0200 7fe016a53700 20 req 6146865621466741246 0.414006233s get_system_obj_state: rctx=0x7fe016a49b50 obj=default.rgw.meta:roles:roles.5dc284b1-e24e-49e2-9fbd-100d1792234f state=0x5653644249a0 s->prefetch_data=0
2022-10-27T10:39:42.223+0200 7fe016a53700 10 req 6146865621466741246 0.414006233s cache get: name=default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f : type miss (requested=0x6, cached=0x3)
2022-10-27T10:39:42.223+0200 7fe016a53700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11909 11.0 11:29d21615:roles::roles.5dc284b1-e24e-49e2-9fbd-100d1792234f:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x5653646a9000 con 0x5653635c7000
2022-10-27T10:39:42.223+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1986 ==== osd_op_reply(11909 roles.5dc284b1-e24e-49e2-9fbd-100d1792234f [getxattrs out=4b,stat out=16b] v0'0 uv69 ondisk = 0) v8 ==== 228+0+20 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.223+0200 7fe016a53700 10 req 6146865621466741246 0.414006233s cache put: name=default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f info.flags=0x6
2022-10-27T10:39:42.224+0200 7fe016a53700 10 req 6146865621466741246 0.415006280s moving default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f to cache LRU end
2022-10-27T10:39:42.224+0200 7fe016a53700 20 req 6146865621466741246 0.415006280s get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.224+0200 7fe016a53700 10 req 6146865621466741246 0.415006280s cache get: name=default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.224+0200 7fe016a53700 2 req 6146865621466741246 0.415006280s iam:get_role completing
2022-10-27T10:39:42.224+0200 7fe016a53700 2 req 6146865621466741246 0.415006280s iam:get_role op status=0
2022-10-27T10:39:42.224+0200 7fe016a53700 2 req 6146865621466741246 0.415006280s iam:get_role http status=200
2022-10-27T10:39:42.224+0200 7fe016a53700 1 ====== req done req=0x7fe016a4ab90 op status=0 http_status=200 latency=0.415006280s ======
2022-10-27T10:39:42.224+0200 7fe016a53700 1 civetweb: 0x56536388a000: 131.154.97.209 - - [27/Oct/2022:10:39:41 +0200] "POST / HTTP/1.1" 200 1116 - Boto3/1.23.10 Python/3.6.9 Linux/4.15.0-193-generic Botocore/1.26.10
2022-10-27T10:39:42.234+0200 7fe016252700 20 CONTENT_LENGTH=1491
2022-10-27T10:39:42.234+0200 7fe016252700 20 CONTENT_TYPE=application/x-www-form-urlencoded; charset=utf-8
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_ACCEPT_ENCODING=identity
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_AMZ_SDK_INVOCATION_ID=99c4a044-ca8b-4390-a0e9-f4c4d2a53adb
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_AMZ_SDK_REQUEST=attempt=1
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_HOST=ceph-mon01-tb.cloud.cnaf.infn.it:7480
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_USER_AGENT=Boto3/1.23.10 Python/3.6.9 Linux/4.15.0-193-generic Botocore/1.26.10
2022-10-27T10:39:42.234+0200 7fe016252700 20 HTTP_VERSION=1.1
2022-10-27T10:39:42.234+0200 7fe016252700 20 REMOTE_ADDR=131.154.97.209
2022-10-27T10:39:42.234+0200 7fe016252700 20 REQUEST_METHOD=POST
2022-10-27T10:39:42.234+0200 7fe016252700 20 REQUEST_URI=/
2022-10-27T10:39:42.234+0200 7fe016252700 20 SCRIPT_URI=/
2022-10-27T10:39:42.234+0200 7fe016252700 20 SERVER_PORT=7480
2022-10-27T10:39:42.234+0200 7fe016252700 1 ====== starting new request req=0x7fe016249b90 =====
2022-10-27T10:39:42.234+0200 7fe016252700 2 req 12246468151010777600 0.000000000s initializing for trans_id = tx00000a9f431e61621da00-00635a43ce-6b044ce-default
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s rgw api priority: s3=8 s3website=7
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s host=ceph-mon01-tb.cloud.cnaf.infn.it
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s final domain/bucket subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0 s->info.domain= s->info.request_uri=/
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s get_handler handler=26RGWHandler_REST_Service_S3
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s handler=26RGWHandler_REST_Service_S3
2022-10-27T10:39:42.234+0200 7fe016252700 2 req 12246468151010777600 0.000000000s getting op 4
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s Content of POST: Action=AssumeRoleWithWebIdentity&Version=2011-06-15&RoleArn=arn%3Aaws%3Aiam%3A%3A%3Arole%2FS3Accesswebid&RoleSessionName=Bob2&DurationSeconds=3600&WebIdentityToken=eyJhbGciOiJSUzI1NiIsInR5cCIgOiAiSldUIiwia2lkIiA6ICJVaXBGTGo1WV8wS0YyZUFIUFFRMGZiLTBHa0RvVjE0dXdCSTVoblN6MTI0In0.eyJleHAiOjE2NjY4NjAyNTAsImlhdCI6MTY2Njg1OTk1MCwianRpIjoiZmNmNTg1YzktZjBhOS00NzFjLWJmNDYtYjUwYzk2ZWJmZmMzIiwiaXNzIjoiaHR0cHM6Ly9rZXljbG9hay1kZW1vLmNsb3VkLmNuYWYuaW5mbi5pdDo4NDQzL3JlYWxtcy9kZW1vIiwiYXVkIjoiYWNjb3VudCIsInN1YiI6ImY5YmRlMmYwLTFmYzUtNDYwYS05ZjBkLWUxYmNmNTY0ZWY2YSIsInR5cCI6IkJlYXJlciIsImF6cCI6InRlc3RpbmciLCJhY3IiOiIxIiwicmVhbG1fYWNjZXNzIjp7InJvbGVzIjpbIm9mZmxpbmVfYWNjZXNzIiwidW1hX2F1dGhvcml6YXRpb24iLCJkZWZhdWx0LXJvbGVzLWRlbW8iXX0sInJlc291cmNlX2FjY2VzcyI6eyJ0ZXN0aW5nIjp7InJvbGVzIjpbInVtYV9wcm90ZWN0aW9uIl19LCJhY2NvdW50Ijp7InJvbGVzIjpbIm1hbmFnZS1hY2NvdW50IiwibWFuYWdlLWFjY291bnQtbGlua3MiLCJ2aWV3LXByb2ZpbGUiXX19LCJzY29wZSI6Im9wZW5pZCBlbWFpbCBwcm9maWxlIiwiZW1haWxfdmVyaWZpZWQiOmZhbHNlLCJjbGllbnRJZCI6InRlc3RpbmciLCJjbGllbnRIb3N0IjoiMTMxLjE1NC45Ny4yMDkiLCJwcmVmZXJyZWRfdXNlcm5hbWUiOiJzZXJ2aWNlLWFjY291bnQtdGVzdGluZyIsImNsaWVudEFkZHJlc3MiOiIxMzEuMTU0Ljk3LjIwOSJ9.tZvdHhJ5bUmPfxS2gi2utedmGVKQdREhj42D59EJlVL8lgDmVPAAJCD9BYLh5m_U41r1RmBrbpAE-749zacx7wm_ZZywi79PYtekHtXg_Mq0IDupR7UKowzPlo-Wj43ksZe0LWfoAbf-FdQCqlBZcqolXhI-LFanMA1SsmgQNi8kS1U2EVnvOxQj3Y1DpFiJ683xlSapkq_z5im8UcANa3JlKSeKE3GWtuR4U0nXUazuby42MKoLOJpw7p8qIU13szP2pX8T1hJIQr2LZF66_k-xYCRVCB312nrmzPUjFnU8MkLmd-SrFkKXT9iiYtBJP4MuRvhlK6hGVL_f8qzAyw
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s sts:assume_role_web_identity op=31RGWSTSAssumeRoleWithWebIdentity
2022-10-27T10:39:42.234+0200 7fe016252700 2 req 12246468151010777600 0.000000000s sts:assume_role_web_identity verifying requester
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s sts:assume_role_web_identity rgw::auth::sts::DefaultStrategy: trying rgw::auth::sts::WebTokenEngine
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s sts:assume_role_web_identity payload = {"exp":1666860250,"iat":1666859950,"jti":"fcf585c9-f0a9-471c-bf46-b50c96ebffc3","iss":"https://keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo","aud":"account","sub":"f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a","typ":"Bearer","azp":"testing","acr":"1","realm_access":{"roles":["offline_access","uma_authorization","default-roles-demo"]},"resource_access":{"testing":{"roles":["uma_protection"]},"account":{"roles":["manage-account","manage-account-links","view-profile"]}},"scope":"openid email profile","email_verified":false,"clientId":"testing","clientHost":"131.154.97.209","preferred_username":"service-account-testing","clientAddress":"131.154.97.209"}
2022-10-27T10:39:42.234+0200 7fe016252700 20 req 12246468151010777600 0.000000000s sts:assume_role_web_identity get_system_obj_state: rctx=0x7fe016248140 obj=default.rgw.meta:oidc:oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo state=0x56536462e2e0 s->prefetch_data=0
2022-10-27T10:39:42.234+0200 7fe016252700 10 req 12246468151010777600 0.000000000s sts:assume_role_web_identity cache get: name=default.rgw.meta+oidc+oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo : type miss (requested=0x6, cached=0x3)
2022-10-27T10:39:42.234+0200 7fe016252700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11910 11.0 11:2db8f34f:oidc::oidc_url.keycloak-demo.cloud.cnaf.infn.it%3a8443%2frealms%2fdemo:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x565364898400 con 0x5653635c7000
2022-10-27T10:39:42.235+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1987 ==== osd_op_reply(11910 oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo [getxattrs out=4b,stat out=16b] v0'0 uv48 ondisk = 0) v8 ==== 244+0+20 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.235+0200 7fe016252700 10 req 12246468151010777600 0.001000015s sts:assume_role_web_identity cache put: name=default.rgw.meta+oidc+oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo info.flags=0x6
2022-10-27T10:39:42.235+0200 7fe016252700 10 req 12246468151010777600 0.001000015s sts:assume_role_web_identity moving default.rgw.meta+oidc+oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo to cache LRU end
2022-10-27T10:39:42.235+0200 7fe016252700 20 req 12246468151010777600 0.001000015s sts:assume_role_web_identity get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.235+0200 7fe016252700 10 req 12246468151010777600 0.001000015s sts:assume_role_web_identity cache get: name=default.rgw.meta+oidc+oidc_url.keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.235+0200 7fe016252700 20 sending request to https://keycloak-demo.cloud.cnaf.infn.it:8443/realms/demo/protocol/openid-connect/certs
2022-10-27T10:39:42.235+0200 7fe016252700 20 register_request mgr=0x56536275fd40 req_data->id=58, curl_handle=0x5653635799e0
2022-10-27T10:39:42.235+0200 7fe03eaa3700 20 link_request req_data=0x56536475da40 req_data->id=58, curl_handle=0x5653635799e0
2022-10-27T10:39:42.240+0200 7fe016252700 20 req 12246468151010777600 0.006000091s sts:assume_role_web_identity HTTP status: 200
2022-10-27T10:39:42.240+0200 7fe016252700 20 req 12246468151010777600 0.006000091s sts:assume_role_web_identity JSON Response is: {"keys":[{"kid":"UipFLj5Y_0KF2eAHPQQ0fb-0GkDoV14uwBI5hnSz124","kty":"RSA","alg":"RS256","use":"sig","n":"1FrcELdOzfj7RX7oQ6vP47CXrlQKuuzE8fiesJDxaUoWDqmimddcLjCObl5lLZiLpxvVqIRKTh0TwA2qJiXifIxetBB8tNnMb_NtZX7H3MLkkvvnvIxmpYL4DraXQQi-ebiFyCDgMG1aqzXSlpItHRRX8JCP7a7IcLKDDYHre1IjOElfcxdS1GrOEdy4iyTpx27fMsx0vBQPogNGpl3R_UcAJzHMSuWpbXfehT01GhHEAqaG7PuwaelfjK0n4Mvm3E-XAa4NTlePSbR9oZq1yomzCKI_4zV38cMWel2VxZKUv701Xb_hMxIWePDXSDW_4L-8ka4yGru-idQCrmPL1w","e":"AQAB","x5c":["MIIClzCCAX8CBgGEFCiAijANBgkqhkiG9w0BAQsFADAPMQ0wCwYDVQQDDARkZW1vMB4XDTIyMTAyNjExNTY0OVoXDTMyMTAyNjExNTgyOVowDzENMAsGA1UEAwwEZGVtbzCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBANRa3BC3Ts34+0V+6EOrz+Owl65UCrrsxPH4nrCQ8WlKFg6popnXXC4wjm5eZS2Yi6cb1aiESk4dE8ANqiYl4nyMXrQQfLTZzG/zbWV+x9zC5JL757yMZqWC+A62l0EIvnm4hcgg4DBtWqs10paSLR0UV/CQj+2uyHCygw2B63tSIzhJX3MXUtRqzhHcuIsk6cdu3zLMdLwUD6IDRqZd0f1HACcxzErlqW133oU9NRoRxAKmhuz7sGnpX4ytJ+DL5txPlwGuDU5Xj0m0faGatcqJswiiP+M1d/HDFnpdlcWSlL+9NV2/4TMSFnjw10g1v+C/vJGuMhq7vonUAq5jy9cCAwEAATANBgkqhkiG9w0BAQsFAAOCAQEACOh3EV1eqi3FWRl3bLq6cqW3A3/J3lJx/ZOWA+06steM4eileiKdiErwW6qt3OiqL4G3QsttD3saWLCftYZuApxX3D2x5nUwYVr+xsKKK4iWaZ+21/n2RA/Sux2aY/Sc8y/WQVGXeStWqjll5mOToPImCLibHmx42pcSPJkj7vodBJyjJWf2jfvV0qvFWv47pTlmHEchypkUIkXejFeJS6SyjWMErEUC5DRorx8vz3/KD34wCBQUSVWN1qfGvIgnzYmMpaCzg/kSzbpQK+H7yO27uxzK0i/+PkHykh8gRBYwsvQ49dlUomOaNcCh/7e1O0VI4O3/x0csH+mZTO8z+A=="],"x5t":"LIR-D0hdLWLFB7hDspQHSvNglCU","x5t#S256":"g3-eS81-HLsbMQrRTf3B01mAdXBAQ5LcCUSzScctRKM"},{"kid":"XD-wohiPQe1EFG24eTzuGQI-g-GPUIlP1pE4hBzMtN8","kty":"RSA","alg":"RSA-OAEP","use":"enc","n":"uLoNIVFu3LTUtmUnma1CgrztG1ZmFQ8P5OXrT0VlcbkKF38LqUQPvVecBwZUpsrXiVvZQYwOhp4H7UcvmsdSfIF5C_NDo-VRnwyBXkK-fRb3GYcKqDu-nAdVA4ZuG2P2315Mup1bBGjx_8oRvd-uSW_2FeTcfxWQ3-4sUnyF9w-lgAq65D6w-zKjhqe7gfKgH_XiJDps3Ymj-1lgIPfQqB2BOg0MjYGZHak070hT-mHXjEage2H92ujBaQZ1HBAEH-j8GKFl9JniSjBxc6sPrp_rlFYibVPMPxpCCtRLQW3HNnUCuzO9KB79WtTB-zDjmTYk20iNKMyct86Tlwdo3Q","e":"AQAB","x5c":["MIIClzCCAX8CBgGEFCiBbDANBgkqhkiG9w0BAQsFADAPMQ0wCwYDVQQDDARkZW1vMB4XDTIyMTAyNjExNTY0OVoXDTMyMTAyNjExNTgyOVowDzENMAsGA1UEAwwEZGVtbzCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBALi6DSFRbty01LZlJ5mtQoK87RtWZhUPD+Tl609FZXG5Chd/C6lED71XnAcGVKbK14lb2UGMDoaeB+1HL5rHUnyBeQvzQ6PlUZ8MgV5Cvn0W9xmHCqg7vpwHVQOGbhtj9t9eTLqdWwRo8f/KEb3frklv9hXk3H8VkN/uLFJ8hfcPpYAKuuQ+sPsyo4anu4HyoB/14iQ6bN2Jo/tZYCD30KgdgToNDI2BmR2pNO9IU/ph14xGoHth/drowWkGdRwQBB/o/BihZfSZ4kowcXOrD66f65RWIm1TzD8aQgrUS0FtxzZ1ArszvSge/VrUwfsw45k2JNtIjSjMnLfOk5cHaN0CAwEAATANBgkqhkiG9w0BAQsFAAOCAQEAjkk2F7/sb73E8LHV4TTjpl7j3IKTtDWB7GgSFonJs1KLienK/1zUKyjdR8gJ/F6BIOrSsxsMV5sDRmz0zXPhQSo1Y2pP2FRquUCYf4EFR2X8/HvcL0rbFVybfc/N0kUo80dTAoKla/l0P+bvf/eOAR6saP0CD9buGnkANGTaPswOxFGaQP8LPYrVBJYCeOagMgQ4irFYzQRbsdN4q86phOjq1Y4IoXV7b2o5RDKAAewkuWDNvlVsya//xGeEOxeP875KIo74xvTUKk12W7ELAT+ZUqLNouAxj1sthMwYTWPXAbnt5tJD2uXoKSJjX25WTZj9l8e1OwOSu6aMFIrWAw=="],"x5t":"vVkkPwlaJFh6duz-pVDaeqs0TzA","x5t#S256":"Q-6aXA6XCqjeSQ7HhknwYqgG0fDR9AyEHZDpdD699wI"}]}0EgTGltaXRlZDEhMB8GA1UE
AwwYQUFBIENlcnRpZmljYXRlIFNlcnZpY2VzMB4XDTE5MDMxMjAwMDAwMFoXDTI4
MTIzMTIzNTk1OVowgYgxCzAJBgNVBAYTAlVTMRMwEQYDVQQIEwpOZXcgSmVyc2V5
MRQwEgYDVQQHEwtKZXJzZXkgQ2l0eTEeMBwGA1UEChMVVGhlIFVTRVJUUlVTVCBO
ZXR3b3JrMS4wLAYDVQQDEyVVU0VSVHJ1c3QgUlNBIENlcnRpZmljYXRpb24gQXV0
aG9yaXR5MIICIjANBgkqhkiG9w0BAQEFAAOCAg8AMIICCgKCAgEAgBJlFzYOw9sI
s9CsVw127c0n00ytUINh4qogTQktZAnczomfzD2p7PbPwdzx07HWezcoEStH2jnG
vDoZtF+mvX2do2NCtnbyqTsrkfjib9DsFiCQCT7i6HTJGLSR1GJk23+jBvGIGGqQ
Ijy8/hPwhxR79uQfjtTkUcYRZ0YIUcuGFFQ/vDP+fmyc/xadGL1RjjWmp2bIcmfb
IWax1Jt4A8BQOujM8Ny8nkz+rwWWNR9XWrf/zvk9tyy29lTdyOcSOk2uTIq3XJq0
tyA9yn8iNK5+O2hmAUTnAU5GU5szYPeUvlM3kHND8zLDU+/bqv50TmnHa4xgk97E
xwzf4TKuzJM7UXiVZ4vuPVb+DNBpDxsP8yUmazNt925H+nND5X4OpWaxKXwyhGNV
icQNwZNUMBkTrNN9N6frXTpsNVzbQdcS2qlJC9/YgIoJk2KOtWbPJYjNhLixP6Q5
D9kCnusSTJV882sFqV4Wg8y4Z+LoE53MW4LTTLPtW//e5XOsIzstAL81VXQJSdhJ
WBp/kjbmUZIO8yZ9HE0XvMnsQybQv0FfQKlERPSZ51eHnlAfV1SoPv10Yy+xUGUJ
5lhCLkMaTLTwJUdZ+gQek9QmRkpQgbLevni3/GcV4clXhB4PY9bpYrrWX1Uu6lzG
KAgEJTm4Diup8kyXHAc/DVL17e8vgg8CAwEAAaOB8jCB7zAfBgNVHSMEGDAWgBSg
EQojPpbxB+zirynvgqV/0DCktDA�RMW�
2022-10-27T10:39:42.240+0200 7fe016252700 20 req 12246468151010777600 0.006000091s sts:assume_role_web_identity Certificate is: -----BEGIN CERTIFICATE-----
MIIClzCCAX8CBgGEFCiAijANBgkqhkiG9w0BAQsFADAPMQ0wCwYDVQQDDARkZW1vMB4XDTIyMTAyNjExNTY0OVoXDTMyMTAyNjExNTgyOVowDzENMAsGA1UEAwwEZGVtbzCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBANRa3BC3Ts34+0V+6EOrz+Owl65UCrrsxPH4nrCQ8WlKFg6popnXXC4wjm5eZS2Yi6cb1aiESk4dE8ANqiYl4nyMXrQQfLTZzG/zbWV+x9zC5JL757yMZqWC+A62l0EIvnm4hcgg4DBtWqs10paSLR0UV/CQj+2uyHCygw2B63tSIzhJX3MXUtRqzhHcuIsk6cdu3zLMdLwUD6IDRqZd0f1HACcxzErlqW133oU9NRoRxAKmhuz7sGnpX4ytJ+DL5txPlwGuDU5Xj0m0faGatcqJswiiP+M1d/HDFnpdlcWSlL+9NV2/4TMSFnjw10g1v+C/vJGuMhq7vonUAq5jy9cCAwEAATANBgkqhkiG9w0BAQsFAAOCAQEACOh3EV1eqi3FWRl3bLq6cqW3A3/J3lJx/ZOWA+06steM4eileiKdiErwW6qt3OiqL4G3QsttD3saWLCftYZuApxX3D2x5nUwYVr+xsKKK4iWaZ+21/n2RA/Sux2aY/Sc8y/WQVGXeStWqjll5mOToPImCLibHmx42pcSPJkj7vodBJyjJWf2jfvV0qvFWv47pTlmHEchypkUIkXejFeJS6SyjWMErEUC5DRorx8vz3/KD34wCBQUSVWN1qfGvIgnzYmMpaCzg/kSzbpQK+H7yO27uxzK0i/+PkHykh8gRBYwsvQ49dlUomOaNcCh/7e1O0VI4O3/x0csH+mZTO8z+A==
-----END CERTIFICATE-----
2022-10-27T10:39:42.241+0200 7fe016252700 20 req 12246468151010777600 0.007000106s sts:assume_role_web_identity rgw::auth::sts::WebTokenEngine granted access
2022-10-27T10:39:42.241+0200 7fe016252700 20 req 12246468151010777600 0.007000106s sts:assume_role_web_identity get_system_obj_state: rctx=0x7fe016248548 obj=default.rgw.meta:users.uid:$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a state=0x56536462e2e0 s->prefetch_data=0
2022-10-27T10:39:42.241+0200 7fe016252700 10 req 12246468151010777600 0.007000106s sts:assume_role_web_identity cache get: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a : expiry miss
2022-10-27T10:39:42.241+0200 7fe016252700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11911 11.3 11:eb7775b6:users.uid::$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x565364898800 con 0x5653635c7000
2022-10-27T10:39:42.241+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1988 ==== osd_op_reply(11911 $oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a [getxattrs out=75b,stat out=16b] v0'0 uv43 ondisk = 0) v8 ==== 228+0+91 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.242+0200 7fe016252700 10 req 12246468151010777600 0.008000121s sts:assume_role_web_identity cache put: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a info.flags=0x6
2022-10-27T10:39:42.242+0200 7fe016252700 10 req 12246468151010777600 0.008000121s sts:assume_role_web_identity adding default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a to cache LRU end
2022-10-27T10:39:42.242+0200 7fe016252700 10 req 12246468151010777600 0.008000121s sts:assume_role_web_identity updating xattr: name=ceph.objclass.version bl.length()=42
2022-10-27T10:39:42.242+0200 7fe016252700 20 req 12246468151010777600 0.008000121s sts:assume_role_web_identity get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.242+0200 7fe016252700 10 req 12246468151010777600 0.008000121s sts:assume_role_web_identity cache get: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a : type miss (requested=0x1, cached=0x6)2022-10-27T10:39:42.242+0200 7fe016252700 20 req 12246468151010777600 0.008000121s sts:assume_role_web_identity rados->read ofs=0 len=0
2022-10-27T10:39:42.242+0200 7fe016252700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11912 11.3 11:eb7775b6:users.uid::$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a:head [read 0~0] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x565364469400 con 0x5653635c7000
2022-10-27T10:39:42.249+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1989 ==== osd_op_reply(11912 $oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a [read 0~257 out=257b] v0'0 uv43 ondisk = 0) v8 ==== 186+0+257 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.249+0200 7fe016252700 20 req 12246468151010777600 0.015000227s sts:assume_role_web_identity rados_obj.operate() r=0 bl.length=257
2022-10-27T10:39:42.249+0200 7fe016252700 10 req 12246468151010777600 0.015000227s sts:assume_role_web_identity cache put: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a info.flags=0x1
2022-10-27T10:39:42.249+0200 7fe016252700 10 req 12246468151010777600 0.015000227s sts:assume_role_web_identity moving default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a to cache LRU end
2022-10-27T10:39:42.249+0200 7fe016252700 2 req 12246468151010777600 0.015000227s sts:assume_role_web_identity normalizing buckets and tenants
2022-10-27T10:39:42.249+0200 7fe016252700 10 req 12246468151010777600 0.015000227s s->object=<NULL> s->bucket=
2022-10-27T10:39:42.249+0200 7fe016252700 2 req 12246468151010777600 0.015000227s sts:assume_role_web_identity init permissions
2022-10-27T10:39:42.249+0200 7fe016252700 20 req 12246468151010777600 0.015000227s sts:assume_role_web_identity get_system_obj_state: rctx=0x7fe0162480d8 obj=default.rgw.meta:users.uid:$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a state=0x56536462e2e0 s->prefetch_data=0
2022-10-27T10:39:42.249+0200 7fe016252700 10 req 12246468151010777600 0.015000227s sts:assume_role_web_identity cache get: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a : type miss (requested=0x6, cached=0x3)2022-10-27T10:39:42.249+0200 7fe016252700 1 -- 10.10.96.132:0/4039468555 --> [v2:10.10.96.115:6800/3364353,v1:10.10.96.115:6801/3364353] -- osd_op(unknown.0.0:11913 11.3 11:eb7775b6:users.uid::$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e6899043) v8 -- 0x565364888c00 con 0x5653635c7000
2022-10-27T10:39:42.250+0200 7fe0412a8700 1 -- 10.10.96.132:0/4039468555 <== osd.3 v2:10.10.96.115:6800/3364353 1990 ==== osd_op_reply(11913 $oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a [getxattrs out=75b,stat out=16b] v0'0 uv43 ondisk = 0) v8 ==== 228+0+91 (crc 0 0 0) 0x5653646778c0 con 0x5653635c7000
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s sts:assume_role_web_identity cache put: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a info.flags=0x6
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s sts:assume_role_web_identity moving default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a to cache LRU end
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s sts:assume_role_web_identity updating xattr: name=ceph.objclass.version bl.length()=42
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s sts:assume_role_web_identity get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s sts:assume_role_web_identity Read xattr: user.rgw.idtag
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s sts:assume_role_web_identity cache get: name=default.rgw.meta+users.uid+$oidc$f9bde2f0-1fc5-460a-9f0d-e1bcf564ef6a : hit (requested=0x3, cached=0x7)
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity recalculating target
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity reading permissions
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity init op
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity verifying op mask
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s sts:assume_role_web_identity required_mask= 0 user.op_mask=7
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity verifying op permissions
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s get_system_obj_state: rctx=0x7fe0162485d0 obj=default.rgw.meta:roles:role_names.S3Accesswebid state=0x56536462e520 s->prefetch_data=0
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s cache get: name=default.rgw.meta+roles+role_names.S3Accesswebid : hit (requested=0x6, cached=0x7)
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s cache get: name=default.rgw.meta+roles+role_names.S3Accesswebid : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s get_system_obj_state: rctx=0x7fe0162485d0 obj=default.rgw.meta:roles:roles.5dc284b1-e24e-49e2-9fbd-100d1792234f state=0x56536462e520 s->prefetch_data=0
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s cache get: name=default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f : hit (requested=0x6, cached=0x7)
2022-10-27T10:39:42.250+0200 7fe016252700 20 req 12246468151010777600 0.016000243s get_system_obj_state: s->obj_tag was set empty
2022-10-27T10:39:42.250+0200 7fe016252700 10 req 12246468151010777600 0.016000243s cache get: name=default.rgw.meta+roles+roles.5dc284b1-e24e-49e2-9fbd-100d1792234f : hit (requested=0x1, cached=0x7)
2022-10-27T10:39:42.250+0200 7fe016252700 0 req 12246468151010777600 0.016000243s sts:assume_role_web_identity evaluating principal returned deny
2022-10-27T10:39:42.250+0200 7fe016252700 1 req 12246468151010777600 0.016000243s op->ERRORHANDLER: err_no=-1 new_err_no=-1
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity op status=0
2022-10-27T10:39:42.250+0200 7fe016252700 2 req 12246468151010777600 0.016000243s sts:assume_role_web_identity http status=403
2022-10-27T10:39:42.250+0200 7fe016252700 1 ====== req done req=0x7fe016249b90 op status=0 http_status=403 latency=0.016000243s ======
2022-10-27T10:39:42.250+0200 7fe016252700 20 process_request() returned -1
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment