You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@pulsar.apache.org by GitBox <gi...@apache.org> on 2018/10/29 10:33:43 UTC
[GitHub] HaraldGustafsson opened a new issue #2880: Unauthorised when
deleting namespace with superuser role
HaraldGustafsson opened a new issue #2880: Unauthorised when deleting namespace with superuser role
URL: https://github.com/apache/pulsar/issues/2880
#### Expected behavior
All the following admin is done using a superuser role towards a pulsar broker over the REST API.
* create tenant - OK
* create namespace - OK
* Set permission with role testrole on a topic in that namespace - OK
* produce messages on that topic using testrole - OK
* delete topic using force - OK
* delete namespace - should be OK
#### Actual behavior
The step delete namespace return unauthorised, note that I'm using the same superuser role that worked for the other operations.
#### Steps to reproduce
Do as above
#### System configuration
pulsar-2.2.0 (same error in 2.1.0-incubating). Broker run in standalone with authorization and authentication on. Using client certificates for authentication.
#### Log
10:27:01.014 [pulsar-web-53-10] WARN org.apache.pulsar.broker.admin.impl.TenantsBase - [superUser] Failed to create already existing tenant tt5
10:27:01.018 [pulsar-web-53-10] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "PUT https://localhost:8081/admin/v2/tenants/tt5 HTTP/1.1" 409 34 "-" "Python/3.7 aiohttp/3.4.2" 11
10:27:01.031 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741747 xid:547 sent:765 recv:908 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5
10:27:01.036 [pulsar-web-53-1] INFO org.apache.pulsar.broker.admin.impl.TenantsBase - [superUser] updated tenant tt5
10:27:01.041 [pulsar-web-53-1] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/tenants/tt5 HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 18
10:27:01.111 [pulsar-web-53-19] INFO org.apache.pulsar.broker.web.PulsarWebResource - Successfully validated clusters on tenant [tt5]
10:27:01.122 [ProcessThread(sid:0 cport:2181):] INFO org.apache.zookeeper.server.PrepRequestProcessor - Got user-level KeeperException when processing sessionid:0x1001f01ffe0000a type:create cxid:0x225 zxid:0xb5174 txntype:-1 reqpath:n/a Error Path:/admin/policies/tt5/testns1 Error:KeeperErrorCode = NodeExists for /admin/policies/tt5/testns1
10:27:01.125 [pulsar-web-53-19] WARN org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Failed to create namespace tt5/testns1 - already exists
10:27:01.138 [pulsar-web-53-19] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "PUT https://localhost:8081/admin/v2/namespaces/tt5/testns1 HTTP/1.1" 409 37 "-" "Python/3.7 aiohttp/3.4.2" 53
10:27:01.153 [pulsar-web-53-30] INFO org.apache.pulsar.broker.web.PulsarWebResource - Successfully validated clusters on tenant [tt5]
10:27:01.165 [pulsar-web-53-30] INFO org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Successfully updated the replication clusters on namespace tt5/testns1
10:27:01.165 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741749 xid:552 sent:770 recv:914 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.167 [pulsar-web-53-30] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/replication HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 18
10:27:01.177 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@43769a87, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.181 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741750 xid:555 sent:773 recv:918 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.181 [pulsar-web-53-23] INFO org.apache.pulsar.broker.authorization.PulsarAuthorizationProvider - [vworker] Successfully granted access for role vworker: [produce, consume] - namespace tt5/testns1
10:27:01.184 [pulsar-web-53-23] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/permissions/vworker HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 13
10:27:01.191 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@64800b7, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.245 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741751 xid:558 sent:776 recv:922 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.252 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@1f388fa7, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.254 [pulsar-web-53-13] INFO org.apache.pulsar.broker.admin.impl.PersistentTopicsBase - [superUser] Successfully granted access for role testrole: [produce, consume] - topic persistent://tt5/testns1/t1\data
10:27:01.258 [pulsar-web-53-13] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/persistent/tt5/testns1/t1%5Cdata/permissions/testrole HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 20
10:27:01.273 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741752 xid:561 sent:779 recv:926 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.275 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@75e3dffb, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.276 [pulsar-web-53-13] INFO org.apache.pulsar.broker.admin.impl.PersistentTopicsBase - [superUser] Successfully granted access for role testrole: [produce, consume] - topic persistent://tt5/testns1/t1\meta
10:27:01.278 [pulsar-web-53-13] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/persistent/tt5/testns1/t1%5Cmeta/permissions/testrole HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 16
10:27:01.373 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741753 xid:564 sent:782 recv:930 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.379 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@236c162, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.383 [pulsar-web-53-3] INFO org.apache.pulsar.broker.admin.impl.PersistentTopicsBase - [superUser] Successfully granted access for role testrole: [produce, consume] - topic persistent://tt5/testns1/t1\data
10:27:01.389 [pulsar-web-53-3] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/persistent/tt5/testns1/t1%5Cdata/permissions/testrole HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 28
10:27:01.408 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741754 xid:567 sent:785 recv:934 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.414 [pulsar-web-53-3] INFO org.apache.pulsar.broker.admin.impl.PersistentTopicsBase - [superUser] Successfully granted access for role testrole: [produce, consume] - topic persistent://tt5/testns1/t1\meta
10:27:01.419 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@443d242b, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.423 [pulsar-web-53-3] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/persistent/tt5/testns1/t1%5Cmeta/permissions/testrole HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 28
10:27:01.510 [ProcessThread(sid:0 cport:2181):] INFO org.apache.zookeeper.server.PrepRequestProcessor - Got user-level KeeperException when processing sessionid:0x1001f01ffe0000a type:create cxid:0x238 zxid:0xb517b txntype:-1 reqpath:n/a Error Path:/admin/policies/tt5 Error:KeeperErrorCode = NodeExists for /admin/policies/tt5
10:27:01.513 [pulsar-web-53-11] WARN org.apache.pulsar.broker.admin.impl.TenantsBase - [superUser] Failed to create already existing tenant tt5
10:27:01.520 [pulsar-web-53-11] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "PUT https://localhost:8081/admin/v2/tenants/tt5 HTTP/1.1" 409 34 "-" "Python/3.7 aiohttp/3.4.2" 16
10:27:01.533 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741756 xid:571 sent:789 recv:939 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5
10:27:01.535 [pulsar-web-53-11] INFO org.apache.pulsar.broker.admin.impl.TenantsBase - [superUser] updated tenant tt5
10:27:01.538 [pulsar-web-53-11] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/tenants/tt5 HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 14
10:27:01.586 [pulsar-web-53-10] INFO org.apache.pulsar.broker.web.PulsarWebResource - Successfully validated clusters on tenant [tt5]
10:27:01.589 [ProcessThread(sid:0 cport:2181):] INFO org.apache.zookeeper.server.PrepRequestProcessor - Got user-level KeeperException when processing sessionid:0x1001f01ffe0000a type:create cxid:0x23d zxid:0xb517d txntype:-1 reqpath:n/a Error Path:/admin/policies/tt5/testns1 Error:KeeperErrorCode = NodeExists for /admin/policies/tt5/testns1
10:27:01.591 [pulsar-web-53-10] WARN org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Failed to create namespace tt5/testns1 - already exists
10:27:01.593 [pulsar-web-53-10] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "PUT https://localhost:8081/admin/v2/namespaces/tt5/testns1 HTTP/1.1" 409 37 "-" "Python/3.7 aiohttp/3.4.2" 14
10:27:01.607 [pulsar-web-53-22] INFO org.apache.pulsar.broker.web.PulsarWebResource - Successfully validated clusters on tenant [tt5]
10:27:01.611 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741757 xid:576 sent:794 recv:945 queuedpkts:0 pendingresp:1 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.613 [pulsar-web-53-22] INFO org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Successfully updated the replication clusters on namespace tt5/testns1
10:27:01.614 [pulsar-web-53-22] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/replication HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 18
10:27:01.615 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@1f23cebc, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.624 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741758 xid:579 sent:797 recv:949 queuedpkts:0 pendingresp:1 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.627 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@74d4c6a4, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.627 [pulsar-web-53-1] INFO org.apache.pulsar.broker.authorization.PulsarAuthorizationProvider - [vworker] Successfully granted access for role vworker: [produce, consume] - namespace tt5/testns1
10:27:01.631 [pulsar-web-53-1] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/permissions/vworker HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 14
10:27:01.675 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741760 xid:582 sent:800 recv:953 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.680 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@40dd248d, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.683 [pulsar-web-53-31] INFO org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Successfully updated retention configuration: namespace=tt5/testns1, map={"retentionTimeInMinutes":10,"retentionSizeInMB":0}
10:27:01.686 [pulsar-web-53-31] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/retention HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 18
10:27:01.729 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741761 xid:585 sent:803 recv:957 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:01.737 [pulsar-web-53-25] INFO org.apache.pulsar.broker.admin.impl.NamespacesBase - [superUser] Successfully updated the message TTL on namespace tt5/testns1
10:27:01.737 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@6dec4cc1, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:01.759 [pulsar-web-53-25] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:01 +0000] "POST https://localhost:8081/admin/v2/namespaces/tt5/testns1/messageTTL HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 29
10:27:01.769 [pulsar-io-46-4] INFO org.apache.pulsar.broker.service.ServerCnx - New connection from /172.17.0.1:39786
10:27:01.792 [pulsar-io-46-4] INFO org.apache.pulsar.broker.service.ServerCnx - [/172.17.0.1:39786] Client successfully authenticated with tls role superUser and originalPrincipal null
10:27:01.843 [pulsar-io-46-1] INFO org.apache.pulsar.broker.service.ServerCnx - New connection from /172.17.0.1:39788
10:27:01.865 [pulsar-io-46-1] INFO org.apache.pulsar.broker.service.ServerCnx - [/172.17.0.1:39788] Client successfully authenticated with tls role superUser and originalPrincipal null
10:27:01.873 [pulsar-io-46-1] INFO org.apache.pulsar.broker.service.ServerCnx - [/172.17.0.1:39788][persistent://tt5/testns1/t1\data] Creating producer. producerId=0
10:27:01.875 [pulsar-ordered-OrderedExecutor-7-0] INFO org.apache.bookkeeper.mledger.impl.ManagedLedgerImpl - Opening managed ledger tt5/testns1/persistent/t1%5Cdata
10:27:01.877 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.bookkeeper.mledger.impl.MetaStoreImplZookeeper - Creating '/managed-ledgers/tt5/testns1/persistent/t1%5Cdata'
10:27:01.879 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperChildrenCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe00009 local:/127.0.0.1:42438 remoteserver:localhost/127.0.0.1:2181 lastZxid:741762 xid:1381 sent:1381 recv:1400 queuedpkts:0 pendingresp:0 queuedevents:1] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/managed-ledgers/tt5/testns1/persistent
10:27:01.885 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.zookeeper.ZooKeeperChildrenCache - reloadCache called in zookeeperChildrenCache for path /managed-ledgers/tt5/testns1/persistent
10:27:01.888 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.bookkeeper.client.LedgerCreateOp - Ensemble: [127.0.0.1:3181] for ledger: 65
10:27:01.890 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.bookkeeper.mledger.impl.ManagedLedgerImpl - [tt5/testns1/persistent/t1%5Cdata] Created ledger 65
10:27:01.893 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.pulsar.broker.service.persistent.DispatchRateLimiter - [persistent://tt5/testns1/t1\data] [null] setting message-dispatch-rate DispatchRate{dispatchThrottlingRateInMsg=0, dispatchThrottlingRateInByte=0, ratePeriodInSecond=1}
10:27:01.894 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.pulsar.broker.service.persistent.DispatchRateLimiter - [persistent://tt5/testns1/t1\data] [null] configured message-dispatch rate at broker DispatchRate{dispatchThrottlingRateInMsg=0, dispatchThrottlingRateInByte=0, ratePeriodInSecond=1}
10:27:01.896 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.pulsar.broker.service.BrokerService - Created topic persistent://tt5/testns1/t1\data - dedup is disabled
10:27:01.919 [Thread-23] INFO org.apache.pulsar.broker.service.ServerCnx - [/172.17.0.1:39788] Created new producer: Producer{topic=PersistentTopic{topic=persistent://tt5/testns1/t1\data}, client=/172.17.0.1:39788, producerName=standalone-0-17, producerId=0}
10:27:01.970 [pulsar-io-46-1] INFO org.apache.pulsar.broker.service.ServerCnx - [PersistentTopic{topic=persistent://tt5/testns1/t1\data}][standalone-0-17] Closing producer on cnx /172.17.0.1:39788
10:27:01.973 [pulsar-io-46-1] INFO org.apache.pulsar.broker.service.ServerCnx - [PersistentTopic{topic=persistent://tt5/testns1/t1\data}][standalone-0-17] Closed producer on cnx /172.17.0.1:39788
10:27:02.034 [pulsar-web-53-17] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "GET https://localhost:8081/admin/v2/persistent/tt5/testns1 HTTP/1.1" 200 37 "-" "Python/3.7 aiohttp/3.4.2" 4
10:27:02.066 [ProcessThread(sid:0 cport:2181):] INFO org.apache.zookeeper.server.PrepRequestProcessor - Got user-level KeeperException when processing sessionid:0x1001f01ffe00009 type:delete cxid:0x56d zxid:0xb5188 txntype:-1 reqpath:n/a Error Path:/ledgers/00/0000 Error:KeeperErrorCode = Directory not empty for /ledgers/00/0000
10:27:02.068 [BookKeeperClientWorker-OrderedExecutor-1-0] INFO org.apache.bookkeeper.mledger.impl.MetaStoreImplZookeeper - [tt5/testns1/persistent/t1%5Cdata] Remove ManagedLedger
10:27:02.070 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperChildrenCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe00009 local:/127.0.0.1:42438 remoteserver:localhost/127.0.0.1:2181 lastZxid:741768 xid:1391 sent:1391 recv:1410 queuedpkts:0 pendingresp:1 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/managed-ledgers/tt5/testns1/persistent
10:27:02.072 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.bookkeeper.mledger.impl.ManagedLedgerImpl - [tt5/testns1/persistent/t1%5Cdata] Successfully deleted managed ledger
10:27:02.073 [bookkeeper-ml-workers-OrderedExecutor-1-0] INFO org.apache.pulsar.broker.service.persistent.PersistentTopic - [persistent://tt5/testns1/t1\data] Topic deleted
10:27:02.076 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.zookeeper.ZooKeeperChildrenCache - reloadCache called in zookeeperChildrenCache for path /managed-ledgers/tt5/testns1/persistent
10:27:02.078 [pulsar-web-53-11] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE https://localhost:8081/admin/v2/persistent/tt5/testns1/t1%5Cdata?force=true HTTP/1.1" 204 0 "-" "Python/3.7 aiohttp/3.4.2" 16
10:27:02.111 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741770 xid:588 sent:806 recv:961 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:02.115 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@6c3b39ee, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:02.121 [pulsar-web-53-18] WARN org.apache.pulsar.broker.web.AuthenticationFilter - [127.0.0.1] Failed to authenticate HTTP request: Authentication required
10:27:02.121 [pulsar-web-53-18] INFO org.eclipse.jetty.server.RequestLog - 127.0.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE //127.0.0.1:8080/admin/v2/namespaces/tt5/testns1/0x80000000_0xc0000000 HTTP/1.1" 401 382 "-" "Jersey/2.25 (HttpUrlConnection 1.8.0_171)" 1
10:27:02.126 [pulsar-web-53-15] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE https://localhost:8081/admin/v2/namespaces/tt5/testns1 HTTP/1.1" 401 45 "-" "Python/3.7 aiohttp/3.4.2" 18
10:27:02.163 [pulsar-web-53-24] WARN org.apache.pulsar.broker.admin.impl.TenantsBase - [superUser] Failed to delete tenant tt5: not empty
10:27:02.167 [pulsar-web-53-24] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE https://localhost:8081/admin/v2/tenants/tt5 HTTP/1.1" 409 51 "-" "Python/3.7 aiohttp/3.4.2" 9
10:27:02.173 [pulsar-web-53-14] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "GET https://localhost:8081/admin/v2/persistent/tt5/testns1 HTTP/1.1" 200 2 "-" "Python/3.7 aiohttp/3.4.2" 15
10:27:02.211 [pulsar-ordered-OrderedExecutor-6-0-EventThread] INFO org.apache.pulsar.zookeeper.ZooKeeperDataCache - [State:CONNECTED Timeout:30000 sessionid:0x1001f01ffe0000a local:/127.0.0.1:42440 remoteserver:localhost/127.0.0.1:2181 lastZxid:741771 xid:593 sent:811 recv:967 queuedpkts:0 pendingresp:0 queuedevents:0] Received ZooKeeper watch event: WatchedEvent state:SyncConnected type:NodeDataChanged path:/admin/policies/tt5/testns1
10:27:02.215 [pulsar-ordered-OrderedExecutor-0-0] INFO org.apache.pulsar.broker.service.BrokerService - /admin/policies/tt5/testns1 updating with Policies{auth_policies=org.apache.pulsar.common.policies.data.AuthPolicies@3e08232b, replication_clusters=[standalone], bundles=BundlesData{numBundles=4, boundaries=[0x00000000, 0x40000000, 0x80000000, 0xc0000000, 0xffffffff]}, backlog_quota_map={}, persistence=null, deduplicationEnabled=null, clusterDispatchRate={}, latency_stats_sample_rate={}, antiAffinityGroup=null, message_ttl_in_seconds=600, retention_policies=RetentionPolicies{retentionTimeInMinutes=10, retentionSizeInMB=0}, deleted=true, encryption_required=false, subscription_auth_mode=None, max_producers_per_topic=0, max_consumers_per_topic=0, max_consumers_per_subscription=0, compaction_threshold=0, offload_threshold=-1, offload_deletion_lag_ms=null}
10:27:02.235 [pulsar-web-53-1] WARN org.apache.pulsar.broker.web.AuthenticationFilter - [127.0.0.1] Failed to authenticate HTTP request: Authentication required
10:27:02.236 [pulsar-web-53-1] INFO org.eclipse.jetty.server.RequestLog - 127.0.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE //127.0.0.1:8080/admin/v2/namespaces/tt5/testns1/0x80000000_0xc0000000 HTTP/1.1" 401 382 "-" "Jersey/2.25 (HttpUrlConnection 1.8.0_171)" 1
10:27:02.245 [pulsar-web-53-28] INFO org.eclipse.jetty.server.RequestLog - 172.17.0.1 - - [29/Oct/2018:10:27:02 +0000] "DELETE https://localhost:8081/admin/v2/namespaces/tt5/testns1 HTTP/1.1" 401 45 "-" "Python/3.7 aiohttp/3.4.2" 41
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
With regards,
Apache Git Services