2021-04-28T13:47:59.896+0700 7f3815c69700 1 ====== starting new request req=0x7f37fcc366b0 =====
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 req 299294951 0s canonical headers format = content-encoding:gzip, aws-chunked
2021-04-28T13:47:59.896+0700 7f3815c69700 2 req 299294952 0s initializing for trans_id = tx000000000000011d6e0e8-006089051f-1c7a214-hkg
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 payload request hash = STREAMING-AWS4-HMAC-SHA256-PAYLOAD
2021-04-28T13:47:59.896+0700 7f3815c69700 10 rgw api priority: s3=8 s3website=7
2021-04-28T13:47:59.896+0700 7f3815c69700 10 host=hkcephbe..local
2021-04-28T13:47:59.896+0700 7f3815c69700 20 subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0
2021-04-28T13:47:59.896+0700 7f3815c69700 20 final domain/bucket subdomain= domain= in_hosted_domain=0 in_hosted_domain_s3website=0 s->info.domain= s->info.request_uri=/
2021-04-28T13:47:59.896+0700 7f3815c69700 20 req 299294952 0s get_handler handler=26RGWHandler_REST_Service_S3
2021-04-28T13:47:59.896+0700 7f3815c69700 10 handler=26RGWHandler_REST_Service_S3
2021-04-28T13:47:59.896+0700 7f3815c69700 2 req 299294952 0s getting op 4
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 canonical request = PUT
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 canonical request hash = 7d48d32de639c0084aaf713ab375c275f11c3d2da09c6e952f4ae07ba8f46e1c
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 string to sign = AWS4-HMAC-SHA256
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 body content detected in multiple chunks
2021-04-28T13:47:59.896+0700 7f3856ceb700 10 aws4 seed signature ok... delaying v4 auth
2021-04-28T13:47:59.896+0700 7f3815c69700 10 Content of POST: Action=CreateTopic&Name=test-ceph-event-replication&Attributes.entry.8.key=push-endpoint&Attributes.entry.8.value=kafka://ceph-replicator:rVVAljXfNAUKGy8bvJm4S1t9I9fcRpbqHA1szTzSXvXxCGOVq63ieleTDbmm9GXm@kafkaserver-2p01..local:9093&Attributes.entry.5.key=use-ssl&Attributes.entry.5.value=true&Attributes.entry.9.key=persistent&Attributes.entry.9.value=true&Attributes.entry.4.key=kafka-ack-level&Attributes.entry.4.value=broker
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 date_k = eedde39111635d1ce29037f5241b9ea2996ee74ad31da272659bb7e8378f911e
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 region_k = 097b5fb2031793920eeb87a9e1a6a3f8809a6fcfc285d7619cd82cec9e858b4b
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 service_k = 86f41ff0476496307ae54ef1201ca53e6e63e3ee512a42ef9c84bff5e473cfcb
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 signing_k = 9cc687e37ea1db9c003a983bf122279eb1e79575510f5e6f6fac2f58eda16e54
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 generated signature = db429b71c849ba12f95a0739854ec84470909825e9f114203b21223fdeb43011
2021-04-28T13:47:59.897+0700 7f3856ceb700 15 req 299294951 0.001000010s s3:put_obj string_to_sign=AWS4-HMAC-SHA256
2021-04-28T13:47:59.897+0700 7f3856ceb700 15 req 299294951 0.001000010s s3:put_obj server signature=db429b71c849ba12f95a0739854ec84470909825e9f114203b21223fdeb43011
2021-04-28T13:47:59.897+0700 7f3856ceb700 15 req 299294951 0.001000010s s3:put_obj client signature=db429b71c849ba12f95a0739854ec84470909825e9f114203b21223fdeb43011
2021-04-28T13:47:59.897+0700 7f3856ceb700 15 req 299294951 0.001000010s s3:put_obj compare=0
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 date_k = eedde39111635d1ce29037f5241b9ea2996ee74ad31da272659bb7e8378f911e
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 region_k = 097b5fb2031793920eeb87a9e1a6a3f8809a6fcfc285d7619cd82cec9e858b4b
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 service_k = 86f41ff0476496307ae54ef1201ca53e6e63e3ee512a42ef9c84bff5e473cfcb
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 signing_k = 9cc687e37ea1db9c003a983bf122279eb1e79575510f5e6f6fac2f58eda16e54
2021-04-28T13:47:59.897+0700 7f3815c69700 10 Content of POST: Action=CreateTopic&Name=test-ceph-event-replication&Attributes.entry.8.key=push-endpoint&Attributes.entry.8.value=kafka://ceph-replicator:rVVAljXfNAUKGy8bvJm4S1t9I9fcRpbqHA1szTzSXvXxCGOVq63ieleTDbmm9GXm@kafkaserver-2p01..local:9093&Attributes.entry.5.key=use-ssl&Attributes.entry.5.value=true&Attributes.entry.9.key=persistent&Attributes.entry.9.value=true&Attributes.entry.4.key=kafka-ack-level&Attributes.entry.4.value=broker
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 req 299294951 0.001000010s s3:put_obj rgw::auth::s3::LocalEngine granted access
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 req 299294951 0.001000010s s3:put_obj rgw::auth::s3::AWSAuthStrategy granted access
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj normalizing buckets and tenants
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 s->object=/WHITELABEL-1/PAGETPYE-7/DEVICE-1/LANGUAGE-33/SUBTYPE-0/12784269 s->bucket=seo..prerender
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj init permissions
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 get_system_obj_state: rctx=0x7f38017a5b08 obj=hkg.rgw.meta:root:seo..prerender state=0x559a766992a0 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f3815c69700 10 Content of POST: Action=CreateTopic&Name=test-ceph-event-replication&Attributes.entry.8.key=push-endpoint&Attributes.entry.8.value=kafka://ceph-replicator:rVVAljXfNAUKGy8bvJm4S1t9I9fcRpbqHA1szTzSXvXxCGOVq63ieleTDbmm9GXm@kafkaserver-2p01..local:9093&Attributes.entry.5.key=use-ssl&Attributes.entry.5.value=true&Attributes.entry.9.key=persistent&Attributes.entry.9.value=true&Attributes.entry.4.key=kafka-ack-level&Attributes.entry.4.value=broker
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 cache get: name=hkg.rgw.meta+root+seo..prerender : hit (requested=0x16, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 get_system_obj_state: s->obj_tag was set empty
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 cache get: name=hkg.rgw.meta+root+seo..prerender : hit (requested=0x11, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3856ceb700 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-04-28T13:47:59.897+0700 7f3815c69700 10 req 299294952 0.001000010s iam:pubsub_topic_create scheduling with dmclock client=3 cost=1
2021-04-28T13:47:59.897+0700 7f3815c69700 10 op=29RGWPSCreateTopic_ObjStore_AWS
2021-04-28T13:47:59.897+0700 7f3815c69700 2 req 299294952 0.001000010s iam:pubsub_topic_create verifying requester
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::StrategyRegistry::s3_main_strategy_t: trying rgw::auth::s3::AWSAuthStrategy
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::S3AnonymousEngine
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::s3::S3AnonymousEngine denied with reason=-1
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::s3::AWSAuthStrategy: trying rgw::auth::s3::LocalEngine
2021-04-28T13:47:59.897+0700 7f3815c69700 10 get_canon_resource(): dest=/
2021-04-28T13:47:59.897+0700 7f3815c69700 10 req 299294952 0.001000010s string_to_sign:
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: rctx=0x7f37fcc34368 obj=hkg.rgw.meta:users.keys:95NSQM3LM4B59UF6D89O state=0x559a76b57960 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O : expiry miss
2021-04-28T13:47:59.897+0700 7f3815c69700 20 WARNING: blocking librados call
2021-04-28T13:47:59.897+0700 7f3815c69700 1 -- 10.118.199.2:0/4288086794 --> [v2:10.118.199.101:6800/10848,v1:10.118.199.101:6801/10848] -- osd_op(unknown.0.0:2066530740 24.3 24:c3b14f1b:users.keys::95NSQM3LM4B59UF6D89O:head [getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e9487) v8 -- 0x559a78956a00 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 get_system_obj_state: rctx=0x7f38017a5ee8 obj=hkg.rgw.meta:users.uid:seo state=0x559a72295960 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 cache get: name=hkg.rgw.meta+users.uid+seo : hit (requested=0x6, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 get_system_obj_state: s->obj_tag was set empty
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 Read xattr: user.rgw.idtag
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 cache get: name=hkg.rgw.meta+users.uid+seo : hit (requested=0x3, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj recalculating target
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj reading permissions
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj init op
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj verifying op mask
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 req 299294951 0.001000010s s3:put_obj required_mask= 2 user.op_mask=7
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj verifying op permissions
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 req 299294951 0.001000010s s3:put_obj -- Getting permissions begin with perm_mask=50
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 req 299294951 0.001000010s s3:put_obj Searching permissions for identity=rgw::auth::SysReqApplier -> rgw::auth::LocalApplier(acct_user=seo, acct_name=seo, subuser=, perm_mask=15, is_admin=0) mask=50
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Searching permissions for uid=seo
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Found permission: 15
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Searching permissions for group=1 mask=50
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Permissions for group not found
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Searching permissions for group=2 mask=50
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 Permissions for group not found
2021-04-28T13:47:59.897+0700 7f3856ceb700 5 req 299294951 0.001000010s s3:put_obj -- Getting permissions done for identity=rgw::auth::SysReqApplier -> rgw::auth::LocalApplier(acct_user=seo, acct_name=seo, subuser=, perm_mask=15, is_admin=0), owner=seo, perm=2
2021-04-28T13:47:59.897+0700 7f3856ceb700 10 req 299294951 0.001000010s s3:put_obj identity=rgw::auth::SysReqApplier -> rgw::auth::LocalApplier(acct_user=seo, acct_name=seo, subuser=, perm_mask=15, is_admin=0) requested perm (type)=2, policy perm=2, user_perm_mask=2, acl perm=2
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj verifying op params
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj pre-executing
2021-04-28T13:47:59.897+0700 7f3856ceb700 2 req 299294951 0.001000010s s3:put_obj executing
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 user quota: max_objects=-1 max_size=30786325577728
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 user quota OK: stats.num_objects=81134939 stats.size=2671019145724
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 required alignment=16384
2021-04-28T13:47:59.897+0700 7f3856ceb700 20 max_chunk_size=4194304
2021-04-28T13:47:59.897+0700 7f38ab594700 20 parsed new chunk; signature=69db5e442bca31de9368d9b99c86fd6e29b3d04b55ada667b9a2160fb9563b29, data_length=34341, data_starts_in_stream=87
2021-04-28T13:47:59.897+0700 7f3931ea1700 1 -- 10.118.199.2:0/4288086794 <== osd.38 v2:10.118.199.101:6800/10848 249398457 ==== osd_op_reply(2066530740 95NSQM3LM4B59UF6D89O [getxattrs out=4b,stat out=16b] v0'0 uv855 ondisk = 0) v8 ==== 206+0+20 (crc 0 0 0) 0x559a76b56240 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache put: name=hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O info.flags=0x6
2021-04-28T13:47:59.897+0700 7f3815c69700 10 adding hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O to cache LRU end
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: s->obj_tag was set empty
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O : type miss (requested=0x1, cached=0x6)
2021-04-28T13:47:59.897+0700 7f3815c69700 20 rados->read ofs=0 len=0
2021-04-28T13:47:59.897+0700 7f3815c69700 20 WARNING: blocking librados call
2021-04-28T13:47:59.897+0700 7f3815c69700 1 -- 10.118.199.2:0/4288086794 --> [v2:10.118.199.101:6800/10848,v1:10.118.199.101:6801/10848] -- osd_op(unknown.0.0:2066530741 24.3 24:c3b14f1b:users.keys::95NSQM3LM4B59UF6D89O:head [read 0~0] snapc 0=[] ondisk+read+known_if_redirected e9487) v8 -- 0x559a78956000 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f38acd97700 20 AWSv4ComplMulti: filled=34341
2021-04-28T13:47:59.897+0700 7f3931ea1700 1 -- 10.118.199.2:0/4288086794 <== osd.38 v2:10.118.199.101:6800/10848 249398458 ==== osd_op_reply(2066530741 95NSQM3LM4B59UF6D89O [read 0~7 out=7b] v0'0 uv855 ondisk = 0) v8 ==== 164+0+7 (crc 0 0 0) 0x559a76b56240 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f3815c69700 20 rados_obj.operate() r=0 bl.length=7
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache put: name=hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O info.flags=0x1
2021-04-28T13:47:59.897+0700 7f3815c69700 10 moving hkg.rgw.meta+users.keys+95NSQM3LM4B59UF6D89O to cache LRU end
2021-04-28T13:47:59.897+0700 7f38acd97700 20 AWSv4ComplMulti: string_to_sign=
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: rctx=0x7f37fcc34368 obj=hkg.rgw.meta:users.uid:pix state=0x559a7848dba0 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.uid+pix : type miss (requested=0x16, cached=0x13)
2021-04-28T13:47:59.897+0700 7f3815c69700 20 WARNING: blocking librados call
2021-04-28T13:47:59.897+0700 7f38f1620700 20 parsed new chunk; signature=409a5b002213e75845d69ea3e4af5f4d0fcf163362cb78364bd48fc291325cc2, data_length=0, data_starts_in_stream=34514
2021-04-28T13:47:59.897+0700 7f38f1620700 20 AWSv4ComplMulti: filled=0
2021-04-28T13:47:59.897+0700 7f3815c69700 1 -- 10.118.199.2:0/4288086794 --> [v2:10.118.199.101:6800/10848,v1:10.118.199.101:6801/10848] -- osd_op(unknown.0.0:2066530742 24.3 24:d42b364e:users.uid::pix:head [call version.read in=11b,getxattrs,stat] snapc 0=[] ondisk+read+known_if_redirected e9487) v8 -- 0x559a74075680 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f38f1620700 5 req 299294951 0.001000010s s3:put_obj NOTICE: call to do_aws4_auth_completion
2021-04-28T13:47:59.897+0700 7f38f1620700 20 AWSv4ComplMulti: string_to_sign=
2021-04-28T13:47:59.897+0700 7f38f1620700 10 req 299294951 0.001000010s s3:put_obj v4 auth ok -- do_aws4_auth_completion
2021-04-28T13:47:59.897+0700 7f38f1620700 5 req 299294951 0.001000010s s3:put_obj NOTICE: call to do_aws4_auth_completion
2021-04-28T13:47:59.897+0700 7f38f1620700 20 user quota: max_objects=-1 max_size=30786325577728
2021-04-28T13:47:59.897+0700 7f38f1620700 20 user quota OK: stats.num_objects=81134939 stats.size=2671019145724
2021-04-28T13:47:59.897+0700 7f38f1620700 10 x>> x-amz-content-sha256:STREAMING-AWS4-HMAC-SHA256-PAYLOAD
2021-04-28T13:47:59.897+0700 7f38f1620700 10 x>> x-amz-date:20210428T064759Z
2021-04-28T13:47:59.897+0700 7f38f1620700 10 x>> x-amz-decoded-content-length:34341
2021-04-28T13:47:59.897+0700 7f38f1620700 10 x>> x-amz-meta-storagetimestamp:Sat Apr 24 2021 03:02:55 GMT+0000 (GMT)
2021-04-28T13:47:59.897+0700 7f38f1620700 20 get_obj_state: rctx=0x7f38017a72b0 obj=seo..prerender:/WHITELABEL-1/PAGETPYE-7/DEVICE-1/LANGUAGE-33/SUBTYPE-0/12784269 state=0x559a7232e1e8 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f38f1620700 20 get_obj_state: rctx=0x7f38017a72b0 obj=seo..prerender:/WHITELABEL-1/PAGETPYE-7/DEVICE-1/LANGUAGE-33/SUBTYPE-0/12784269 state=0x559a7232e1e8 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f38f1620700 10 setting object write_tag=9213182a-14ba-48ad-bde9-289a1c0c0de8.29860372.299294951
2021-04-28T13:47:59.897+0700 7f38f1620700 20 bucket index object: hkg.rgw.buckets.index:.dir.9213182a-14ba-48ad-bde9-289a1c0c0de8.6089868.1.6640
2021-04-28T13:47:59.897+0700 7f3931ea1700 1 -- 10.118.199.2:0/4288086794 <== osd.38 v2:10.118.199.101:6800/10848 249398459 ==== osd_op_reply(2066530742 pix [call out=48b,getxattrs out=75b,stat out=16b] v0'0 uv857 ondisk = 0) v8 ==== 231+0+139 (crc 0 0 0) 0x559a76b56240 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f38f1620700 1 -- 10.118.199.2:0/4288086794 --> [v2:10.118.199.101:6800/10848,v1:10.118.199.101:6801/10848] -- osd_op(unknown.0.0:2066530743 26.1b 26:dbc7e3ad:::.dir.9213182a-14ba-48ad-bde9-289a1c0c0de8.6089868.1.6640:head [call rgw.guard_bucket_resharding in=36b,call rgw.bucket_prepare_op in=277b] snapc 0=[] ondisk+write+known_if_redirected e9487) v8 -- 0x559a74d0b900 con 0x559a6ea82c00
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache put: name=hkg.rgw.meta+users.uid+pix info.flags=0x16
2021-04-28T13:47:59.897+0700 7f3815c69700 10 moving hkg.rgw.meta+users.uid+pix to cache LRU end
2021-04-28T13:47:59.897+0700 7f3815c69700 10 updating xattr: name=ceph.objclass.version bl.length()=42
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: s->obj_tag was set empty
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.uid+pix : hit (requested=0x11, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3815c69700 10 chain_cache_entry: cache_locator=hkg.rgw.meta+users.uid+pix
2021-04-28T13:47:59.897+0700 7f3815c69700 15 req 299294952 0.001000010s iam:pubsub_topic_create string_to_sign=POST
2021-04-28T13:47:59.897+0700 7f3815c69700 15 req 299294952 0.001000010s iam:pubsub_topic_create server signature=K/ItGc6ZbAuphnqtpR8MBQHk4bg=
2021-04-28T13:47:59.897+0700 7f3815c69700 15 req 299294952 0.001000010s iam:pubsub_topic_create client signature=K/ItGc6ZbAuphnqtpR8MBQHk4bg=
2021-04-28T13:47:59.897+0700 7f3815c69700 15 req 299294952 0.001000010s iam:pubsub_topic_create compare=0
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::s3::LocalEngine granted access
2021-04-28T13:47:59.897+0700 7f3815c69700 20 req 299294952 0.001000010s iam:pubsub_topic_create rgw::auth::s3::AWSAuthStrategy granted access
2021-04-28T13:47:59.897+0700 7f3815c69700 2 req 299294952 0.001000010s iam:pubsub_topic_create normalizing buckets and tenants
2021-04-28T13:47:59.897+0700 7f3815c69700 10 s->object=<NULL> s->bucket=
2021-04-28T13:47:59.897+0700 7f3815c69700 2 req 299294952 0.001000010s iam:pubsub_topic_create init permissions
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: rctx=0x7f37fcc33ee8 obj=hkg.rgw.meta:users.uid:pix state=0x559a76b57960 s->prefetch_data=0
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.uid+pix : hit (requested=0x6, cached=0x17)
2021-04-28T13:47:59.897+0700 7f3815c69700 20 get_system_obj_state: s->obj_tag was set empty
2021-04-28T13:47:59.897+0700 7f3815c69700 20 Read xattr: user.rgw.idtag
2021-04-28T13:47:59.897+0700 7f3815c69700 10 cache get: name=hkg.rgw.meta+users.uid+pix : hit (requested=0x3, cached=0x17)
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create recalculating target
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create reading permissions
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create init op
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create verifying op mask
2021-04-28T13:47:59.898+0700 7f3815c69700 20 req 299294952 0.002000020s iam:pubsub_topic_create required_mask= 2 user.op_mask=7
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create verifying op permissions
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create verifying op params
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create pre-executing
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create executing
2021-04-28T13:47:59.898+0700 7f3815c69700 1 endpoint validation error: sending password over insecure transport
2021-04-28T13:47:59.898+0700 7f3815c69700 2 req 299294952 0.002000020s iam:pubsub_topic_create completing
2021-04-28T13:47:59.898+0700 7f3832ca3700 2 req 299294952 0.002000020s iam:pubsub_topic_create op status=-22
2021-04-28T13:47:59.898+0700 7f3832ca3700 2 req 299294952 0.002000020s iam:pubsub_topic_create http status=400
2021-04-28T13:47:59.898+0700 7f3832ca3700 1 ====== req done req=0x7f37fcc366b0 op status=-22 http_status=400 latency=0.002000020s ======
2021-04-28T13:47:59.898+0700 7f3832ca3700 1 beast: 0x7f37fcc366b0: 10.118.199.238 - - [2021-04-28T13:47:59.898102+0700] "POST / HTTP/1.1" 400 180 - "curl/7.64.1" -
