Project

General

Profile

Bug #49244 ยป debug.txt

Ist Gab, 02/11/2021 08:41 AM

 
2021-02-11T15:25:50.306+0700 7f7f12d6f700 1 ====== starting new request req=0x7f7ec52756b0 =====
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s initializing for trans_id = tx000000000000000606db9-006024ea0e-ffd554-ash
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 rgw api priority: s3=8 s3website=7
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 host=ascephfelocal
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 final domain/bucket subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0 s->info.domain= s->info.request_uri=/seo..prerender//WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 meta>> HTTP_X_AMZ_CONTENT_SHA256
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 meta>> HTTP_X_AMZ_DATE
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 x>> x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 x>> x-amz-date:20210211T082550Z
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s get_handler handler=22RGWHandler_REST_Obj_S3
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 handler=22RGWHandler_REST_Obj_S3
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s getting op 0
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 req 6319545 0s s3:get_obj scheduling with dmclock client=2 cost=1
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 op=21RGWGetObj_ObjStore_S3
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s s3:get_obj verifying requester
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::StrategyRegistry::s3_main_strategy_t: trying rgw::auth::s3::AWSAuthStrategy
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::S3AnonymousEngine
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::s3::S3AnonymousEngine denied with reason=-1
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::LocalEngine
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 v4 signature format = 81c4c0f7326a6d66dba935e29328ba80faf08e39024e6d4153d9718395fdfc1d
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 v4 credential format = Y8BOG1USWVI21ARU6OVZ/20210211/us-east-1/s3/aws4_request
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 access key id = Y8BOG1USWVI21ARU6OVZ
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 credential scope = 20210211/us-east-1/s3/aws4_request
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 req 6319545 0s canonical headers format = host:ascephfelocal:8080
user-agent:aws-sdk-dotnet-45/3.5.3.2 aws-sdk-dotnet-core/3.5.1.24 .NET_Runtime/4.0 .NET_Framework/4.0 OS/Microsoft_Windows_NT_6.3.9600.0 ClientSync
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20210211T082550Z

2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 payload request hash = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 canonical request = GET
/seo..prerender//WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711

host:ascephfelocal:8080
user-agent:aws-sdk-dotnet-45/3.5.3.2 aws-sdk-dotnet-core/3.5.1.24 .NET_Runtime/4.0 .NET_Framework/4.0 OS/Microsoft_Windows_NT_6.3.9600.0 ClientSync
x-amz-content-sha256:e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date:20210211T082550Z

host;user-agent;x-amz-content-sha256;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 canonical request hash = 87269bd5e93b2f518f8ef4d8ed7333541af1de784aeceeddb4d5e4ec87394c02
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 string to sign = AWS4-HMAC-SHA256
20210211T082550Z
20210211/us-east-1/s3/aws4_request
87269bd5e93b2f518f8ef4d8ed7333541af1de784aeceeddb4d5e4ec87394c02
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 date_k = 925e2c025a8916810cb5f20270c45e43304d68c4d3e7a20ed53fa92c4daccf9c
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 region_k = 456a0ba67c9269b085be58d36a6e6c48b931b16a8c16d9fa57c73628050881bc
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 service_k = f4de8d54cefc0649ee91c6251a72b734437a8b171fb1a4f34257ba807d4b1da7
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 signing_k = ac47269f8c5e9681ea82bf2a02eb2282e235f2936452ad94a36a65919e3fd52b
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 generated signature = 81c4c0f7326a6d66dba935e29328ba80faf08e39024e6d4153d9718395fdfc1d
2021-02-11T15:25:50.306+0700 7f7f12d6f700 15 req 6319545 0s s3:get_obj string_to_sign=AWS4-HMAC-SHA256
20210211T082550Z
20210211/us-east-1/s3/aws4_request
87269bd5e93b2f518f8ef4d8ed7333541af1de784aeceeddb4d5e4ec87394c02
2021-02-11T15:25:50.306+0700 7f7f12d6f700 15 req 6319545 0s s3:get_obj server signature=81c4c0f7326a6d66dba935e29328ba80faf08e39024e6d4153d9718395fdfc1d
2021-02-11T15:25:50.306+0700 7f7f12d6f700 15 req 6319545 0s s3:get_obj client signature=81c4c0f7326a6d66dba935e29328ba80faf08e39024e6d4153d9718395fdfc1d
2021-02-11T15:25:50.306+0700 7f7f12d6f700 15 req 6319545 0s s3:get_obj compare=0
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::s3::LocalEngine granted access
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 req 6319545 0s s3:get_obj rgw::auth::s3::AWSAuthStrategy granted access
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s s3:get_obj normalizing buckets and tenants
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 s->object=/WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711 s->bucket=seo..prerender
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s s3:get_obj init permissions
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 get_system_obj_state: rctx=0x7f7ec5272b18 obj=ash.rgw.meta:root:seo..prerender state=0x55e951144760 s->prefetch_data=0
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 cache get: name=ash.rgw.meta+root+seo..prerender : hit (requested=0x16, cached=0x17)
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 get_system_obj_state: s->obj_tag was set empty
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 cache get: name=ash.rgw.meta+root+seo..prerender : hit (requested=0x11, cached=0x17)
2021-02-11T15:25:50.306+0700 7f7f12d6f700 15 decode_policy Read AccessControlPolicy<AccessControlPolicy xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Owner><ID>seo</ID><DisplayName>seo</DisplayName></Owner><AccessControlList><Grant><Grantee xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:type="CanonicalUser"><ID>seo</ID><DisplayName>seo</DisplayName></Grantee><Permission>FULL_CONTROL</Permission></Grant></AccessControlList></AccessControlPolicy>
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 get_system_obj_state: rctx=0x7f7ec5272ef8 obj=ash.rgw.meta:users.uid:seo state=0x55e9c27589a0 s->prefetch_data=0
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 cache get: name=ash.rgw.meta+users.uid+seo : hit (requested=0x6, cached=0x17)
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 get_system_obj_state: s->obj_tag was set empty
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 Read xattr: user.rgw.idtag
2021-02-11T15:25:50.306+0700 7f7f12d6f700 10 cache get: name=ash.rgw.meta+users.uid+seo : hit (requested=0x3, cached=0x17)
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s s3:get_obj recalculating target
2021-02-11T15:25:50.306+0700 7f7f12d6f700 2 req 6319545 0s s3:get_obj reading permissions
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 get_obj_state: rctx=0x7f7ec52742c0 obj=seo..prerender:/WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711 state=0x55ea21a6d1e8 s->prefetch_data=1
2021-02-11T15:25:50.306+0700 7f7f12d6f700 20 WARNING: blocking librados call
2021-02-11T15:25:50.306+0700 7f7f12d6f700 1 -- 10.46.199.1:0/2839068185 --> [v2:10.46.199.9:6805/1724912,v1:10.46.199.9:6807/1724912] -- osd_op(unknown.0.0:15004293 11.11s0 11:888fcba6:::9213182a-14ba-48ad-bde9-289a1c0c0de8.6034919.1_%2fWHITELABEL-1%2fPAGETPYE-12%2fDEVICE-1%2fLANGUAGE-31%2fSUBTYPE-31%2f545711:head [getxattrs,stat,read 0~4194304] snapc 0=[] ondisk+read+known_if_redirected e2893) v8 -- 0x55e9830d3400 con 0x55e94e886800
2021-02-11T15:25:50.307+0700 7f7ffb740700 1 -- 10.46.199.1:0/2839068185 <== osd.23 v2:10.46.199.9:6805/1724912 642614 ==== osd_op_reply(15004293 9213182a-14ba-48ad-bde9-289a1c0c0de8.6034919.1_/WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711 [getxattrs,stat,read 0~4194304] v0'0 uv0 ondisk = -2 ((2) No such file or directory)) v8 ==== 339+0+0 (crc 0 0 0) 0x55e99b484000 con 0x55e94e886800
2021-02-11T15:25:50.307+0700 7f7f12d6f700 15 decode_policy Read AccessControlPolicy<AccessControlPolicy xmlns="http://s3.amazonaws.com/doc/2006-03-01/"><Owner><ID>seo</ID><DisplayName>seo</DisplayName></Owner><AccessControlList><Grant><Grantee xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:type="CanonicalUser"><ID>seo</ID><DisplayName>seo</DisplayName></Grantee><Permission>FULL_CONTROL</Permission></Grant></AccessControlList></AccessControlPolicy>
2021-02-11T15:25:50.307+0700 7f7f12d6f700 10 req 6319545 0.001000009s s3:get_obj read_permissions on :seo..prerender[9213182a-14ba-48ad-bde9-289a1c0c0de8.6089868.1]):/WHITELABEL-1/PAGETPYE-12/DEVICE-1/LANGUAGE-31/SUBTYPE-31/545711 only_bucket=0 ret=-2
2021-02-11T15:25:50.307+0700 7f7f12d6f700 1 op->ERRORHANDLER: err_no=-2 new_err_no=-2
2021-02-11T15:25:50.307+0700 7f7f12d6f700 2 req 6319545 0.001000009s s3:get_obj op status=0
2021-02-11T15:25:50.307+0700 7f7f12d6f700 2 req 6319545 0.001000009s s3:get_obj http status=404
2021-02-11T15:25:50.307+0700 7f7f12d6f700 1 ====== req done req=0x7f7ec52756b0 op status=0 http_status=404 latency=0.001000009s ======
    (1-1/1)