{"level":"warn","ts":"2026-09-19T01:04:32.877785Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:04:32.877872Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.25:2380","--initial-cluster=instance=https://162.253.55.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-19T01:04:32.87795Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:04:32.877963Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-09-19T01:04:32.877987Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T01:04:32.878655Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"]} {"level":"info","ts":"2026-09-19T01:04:32.87873Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-19T01:04:32.886417Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.457118ms"} {"level":"info","ts":"2026-09-19T01:04:32.897031Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"afeb1bf8b692f9e8","cluster-id":"6bfcc13baae99738"} {"level":"info","ts":"2026-09-19T01:04:32.897174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:04:32.897203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:04:32.897218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft afeb1bf8b692f9e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:04:32.897228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:04:32.897274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"warn","ts":"2026-09-19T01:04:32.917644Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:04:32.919303Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:04:32.922706Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-19T01:04:32.925603Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"afeb1bf8b692f9e8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:04:32.929921Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:04:32.930331Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:04:32.930353Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:04:32.930223Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"afeb1bf8b692f9e8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:04:32.931331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"info","ts":"2026-09-19T01:04:32.934483Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","added-peer-id":"afeb1bf8b692f9e8","added-peer-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-09-19T01:04:32.935258Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T01:04:32.93549Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"afeb1bf8b692f9e8","initial-advertise-peer-urls":["https://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:04:32.93552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:04:32.935658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-09-19T01:04:32.935673Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-09-19T01:04:33.697771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:04:33.697859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:04:33.697925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgPreVoteResp from afeb1bf8b692f9e8 at term 1"} {"level":"info","ts":"2026-09-19T01:04:33.697961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:04:33.69798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgVoteResp from afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-09-19T01:04:33.698008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:04:33.698035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: afeb1bf8b692f9e8 elected leader afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-09-19T01:04:33.699417Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:33.700482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:04:33.700487Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"afeb1bf8b692f9e8","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.25:2379]}","request-path":"/0/members/afeb1bf8b692f9e8/attributes","cluster-id":"6bfcc13baae99738","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:04:33.70053Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:04:33.700784Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:04:33.701049Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:04:33.70149Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:33.70168Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:33.701732Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:33.702954Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.25:2379"} {"level":"info","ts":"2026-09-19T01:04:33.705576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-19T01:04:37.989975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.31673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:04:37.990125Z","caller":"traceutil/trace.go:171","msg":"trace[211308833] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"414.489763ms","start":"2026-09-19T01:04:37.575601Z","end":"2026-09-19T01:04:37.990091Z","steps":["trace[211308833] 'process raft request' (duration: 158.704941ms)","trace[211308833] 'compare' (duration: 255.207308ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:04:37.990285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:04:37.575575Z","time spent":"414.643956ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:04:38.127074Z","caller":"traceutil/trace.go:171","msg":"trace[1546509088] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"133.617719ms","start":"2026-09-19T01:04:37.993433Z","end":"2026-09-19T01:04:38.12705Z","steps":["trace[1546509088] 'read index received' (duration: 129.756357ms)","trace[1546509088] 'applied index is now lower than readState.Index' (duration: 3.858392ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:04:38.127397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.937577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-5yo0w8\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-09-19T01:04:38.127513Z","caller":"traceutil/trace.go:171","msg":"trace[961915121] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"134.169813ms","start":"2026-09-19T01:04:37.99323Z","end":"2026-09-19T01:04:38.127399Z","steps":["trace[961915121] 'process raft request' (duration: 129.8619ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:04:38.127683Z","caller":"traceutil/trace.go:171","msg":"trace[218305169] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-5yo0w8; range_end:; response_count:1; response_revision:205; }","duration":"134.03354ms","start":"2026-09-19T01:04:37.993405Z","end":"2026-09-19T01:04:38.127438Z","steps":["trace[218305169] 'agreement among raft nodes before linearized reading' (duration: 133.726342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:13.077183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.982701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:05:13.077274Z","caller":"traceutil/trace.go:171","msg":"trace[650238014] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:484; }","duration":"130.160426ms","start":"2026-09-19T01:05:12.947093Z","end":"2026-09-19T01:05:13.077253Z","steps":["trace[650238014] 'range keys from in-memory index tree' (duration: 129.88623ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:20.174486Z","caller":"traceutil/trace.go:171","msg":"trace[329333083] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"125.489262ms","start":"2026-09-19T01:05:20.048957Z","end":"2026-09-19T01:05:20.174447Z","steps":["trace[329333083] 'process raft request' (duration: 124.272142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:20.760262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.15957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:05:20.760408Z","caller":"traceutil/trace.go:171","msg":"trace[618289549] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"451.915744ms","start":"2026-09-19T01:05:20.308468Z","end":"2026-09-19T01:05:20.760384Z","steps":["trace[618289549] 'read index received' (duration: 264.509899ms)","trace[618289549] 'applied index is now lower than readState.Index' (duration: 187.395275ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:20.76052Z","caller":"traceutil/trace.go:171","msg":"trace[1618542141] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"512.247401ms","start":"2026-09-19T01:05:20.248246Z","end":"2026-09-19T01:05:20.760493Z","steps":["trace[1618542141] 'process raft request' (duration: 324.749964ms)","trace[1618542141] 'compare' (duration: 186.819425ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:05:20.760677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:05:20.248209Z","time spent":"512.424294ms","remote":"127.0.0.1:49352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:05:20.761185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.706666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w958l\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-19T01:05:20.761399Z","caller":"traceutil/trace.go:171","msg":"trace[1723614951] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w958l; range_end:; response_count:1; response_revision:595; }","duration":"452.994652ms","start":"2026-09-19T01:05:20.308394Z","end":"2026-09-19T01:05:20.761389Z","steps":["trace[1723614951] 'agreement among raft nodes before linearized reading' (duration: 452.111778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:20.761413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.506882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-19T01:05:20.76143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:05:20.308356Z","time spent":"453.068284ms","remote":"127.0.0.1:48980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-w958l\" "} {"level":"info","ts":"2026-09-19T01:05:20.761506Z","caller":"traceutil/trace.go:171","msg":"trace[107497319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"369.847089ms","start":"2026-09-19T01:05:20.391634Z","end":"2026-09-19T01:05:20.761481Z","steps":["trace[107497319] 'agreement among raft nodes before linearized reading' (duration: 369.482202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:20.761549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:05:20.391609Z","time spent":"369.93233ms","remote":"127.0.0.1:49058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:05:20.761616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.522299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:05:20.762258Z","caller":"traceutil/trace.go:171","msg":"trace[940201250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"267.918585ms","start":"2026-09-19T01:05:20.493822Z","end":"2026-09-19T01:05:20.761741Z","steps":["trace[940201250] 'agreement among raft nodes before linearized reading' (duration: 267.350105ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:44.665971Z","caller":"traceutil/trace.go:171","msg":"trace[1069355511] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"208.016419ms","start":"2026-09-19T01:05:44.457923Z","end":"2026-09-19T01:05:44.665939Z","steps":["trace[1069355511] 'read index received' (duration: 207.638014ms)","trace[1069355511] 'applied index is now lower than readState.Index' (duration: 377.135µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:44.666402Z","caller":"traceutil/trace.go:171","msg":"trace[1348792124] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"223.505236ms","start":"2026-09-19T01:05:44.442878Z","end":"2026-09-19T01:05:44.666384Z","steps":["trace[1348792124] 'process raft request' (duration: 222.812067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:44.666575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.215029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:05:44.666631Z","caller":"traceutil/trace.go:171","msg":"trace[1051967171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"173.335431ms","start":"2026-09-19T01:05:44.493281Z","end":"2026-09-19T01:05:44.666617Z","steps":["trace[1051967171] 'agreement among raft nodes before linearized reading' (duration: 173.235249ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:44.667235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.232276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:05:44.66747Z","caller":"traceutil/trace.go:171","msg":"trace[1317120479] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:783; }","duration":"209.467149ms","start":"2026-09-19T01:05:44.457876Z","end":"2026-09-19T01:05:44.667343Z","steps":["trace[1317120479] 'agreement among raft nodes before linearized reading' (duration: 208.655838ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:15.195963Z","caller":"traceutil/trace.go:171","msg":"trace[1338820943] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"122.2152ms","start":"2026-09-19T01:06:15.073721Z","end":"2026-09-19T01:06:15.195936Z","steps":["trace[1338820943] 'process raft request' (duration: 122.061008ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:15.390964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.48153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T01:06:15.391081Z","caller":"traceutil/trace.go:171","msg":"trace[1480193713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1186; }","duration":"150.616691ms","start":"2026-09-19T01:06:15.240443Z","end":"2026-09-19T01:06:15.39106Z","steps":["trace[1480193713] 'range keys from in-memory index tree' (duration: 150.239817ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:31.833353Z","caller":"traceutil/trace.go:171","msg":"trace[1492610154] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"114.008198ms","start":"2026-09-19T01:06:31.719315Z","end":"2026-09-19T01:06:31.833324Z","steps":["trace[1492610154] 'process raft request' (duration: 113.823926ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:59.29413Z","caller":"traceutil/trace.go:171","msg":"trace[1828256461] transaction","detail":"{read_only:false; response_revision:1774; number_of_response:1; }","duration":"122.235262ms","start":"2026-09-19T01:06:59.171864Z","end":"2026-09-19T01:06:59.294099Z","steps":["trace[1828256461] 'process raft request' (duration: 107.874192ms)","trace[1828256461] 'compare' (duration: 14.226279ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:07:06.681101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.257829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:07:06.681229Z","caller":"traceutil/trace.go:171","msg":"trace[172216446] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1883; }","duration":"329.466852ms","start":"2026-09-19T01:07:06.351737Z","end":"2026-09-19T01:07:06.681204Z","steps":["trace[172216446] 'count revisions from in-memory index tree' (duration: 329.136348ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:06.681282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:07:06.351712Z","time spent":"329.557062ms","remote":"127.0.0.1:48942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-09-19T01:07:06.681419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.47261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:07:06.681732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.315419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-19T01:07:06.681911Z","caller":"traceutil/trace.go:171","msg":"trace[1842876572] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1883; }","duration":"239.484101ms","start":"2026-09-19T01:07:06.442315Z","end":"2026-09-19T01:07:06.681799Z","steps":["trace[1842876572] 'range keys from in-memory index tree' (duration: 238.506551ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:06.68156Z","caller":"traceutil/trace.go:171","msg":"trace[35145824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1883; }","duration":"190.718523ms","start":"2026-09-19T01:07:06.490822Z","end":"2026-09-19T01:07:06.68154Z","steps":["trace[35145824] 'range keys from in-memory index tree' (duration: 190.386408ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:07.161304Z","caller":"traceutil/trace.go:171","msg":"trace[375794938] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"177.547204ms","start":"2026-09-19T01:07:06.983732Z","end":"2026-09-19T01:07:07.161279Z","steps":["trace[375794938] 'read index received' (duration: 177.402122ms)","trace[375794938] 'applied index is now lower than readState.Index' (duration: 143.562µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:07:07.161559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.798917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-19T01:07:07.161598Z","caller":"traceutil/trace.go:171","msg":"trace[1867188898] range","detail":"{range_begin:/registry/masterleases/162.253.55.25; range_end:; response_count:1; response_revision:1886; }","duration":"177.909967ms","start":"2026-09-19T01:07:06.983677Z","end":"2026-09-19T01:07:07.161587Z","steps":["trace[1867188898] 'agreement among raft nodes before linearized reading' (duration: 177.720736ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:07.161682Z","caller":"traceutil/trace.go:171","msg":"trace[511691682] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"269.221392ms","start":"2026-09-19T01:07:06.892292Z","end":"2026-09-19T01:07:07.161514Z","steps":["trace[511691682] 'process raft request' (duration: 268.795397ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:19.10189Z","caller":"traceutil/trace.go:171","msg":"trace[1294100960] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"151.386869ms","start":"2026-09-19T01:07:18.95047Z","end":"2026-09-19T01:07:19.101857Z","steps":["trace[1294100960] 'process raft request' (duration: 151.201617ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:19.72824Z","caller":"traceutil/trace.go:171","msg":"trace[1998729482] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"163.016315ms","start":"2026-09-19T01:07:19.565197Z","end":"2026-09-19T01:07:19.728213Z","steps":["trace[1998729482] 'process raft request' (duration: 162.815912ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:19.73213Z","caller":"traceutil/trace.go:171","msg":"trace[833196152] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"152.846983ms","start":"2026-09-19T01:07:19.579258Z","end":"2026-09-19T01:07:19.732105Z","steps":["trace[833196152] 'process raft request' (duration: 152.710242ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:40.240667Z","caller":"traceutil/trace.go:171","msg":"trace[905136599] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2200; }","duration":"203.089596ms","start":"2026-09-19T01:07:40.03755Z","end":"2026-09-19T01:07:40.240639Z","steps":["trace[905136599] 'read index received' (duration: 62.441392ms)","trace[905136599] 'applied index is now lower than readState.Index' (duration: 140.647014ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:07:40.240726Z","caller":"traceutil/trace.go:171","msg":"trace[1548627853] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"235.72019ms","start":"2026-09-19T01:07:40.004992Z","end":"2026-09-19T01:07:40.240712Z","steps":["trace[1548627853] 'process raft request' (duration: 227.543291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:40.240921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.344028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12384"} {"level":"info","ts":"2026-09-19T01:07:40.24097Z","caller":"traceutil/trace.go:171","msg":"trace[299487005] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2122; }","duration":"203.441179ms","start":"2026-09-19T01:07:40.037513Z","end":"2026-09-19T01:07:40.240954Z","steps":["trace[299487005] 'agreement among raft nodes before linearized reading' (duration: 203.238837ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:40.302698Z","caller":"traceutil/trace.go:171","msg":"trace[464915867] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"151.892943ms","start":"2026-09-19T01:07:40.15077Z","end":"2026-09-19T01:07:40.302663Z","steps":["trace[464915867] 'process raft request' (duration: 151.677671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:41.712876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.222312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:07:41.712959Z","caller":"traceutil/trace.go:171","msg":"trace[1048376097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2124; }","duration":"312.382664ms","start":"2026-09-19T01:07:41.400556Z","end":"2026-09-19T01:07:41.712939Z","steps":["trace[1048376097] 'count revisions from in-memory index tree' (duration: 312.142731ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:41.713007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:07:41.400536Z","time spent":"312.456985ms","remote":"127.0.0.1:33772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-19T01:07:41.713297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.820828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:07:41.71344Z","caller":"traceutil/trace.go:171","msg":"trace[551799773] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"304.8542ms","start":"2026-09-19T01:07:41.408551Z","end":"2026-09-19T01:07:41.713405Z","steps":["trace[551799773] 'process raft request' (duration: 120.642669ms)","trace[551799773] 'compare' (duration: 183.555045ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:07:41.713535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:07:41.408524Z","time spent":"304.964362ms","remote":"127.0.0.1:49058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:07:41.976318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.670532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:07:41.976513Z","caller":"traceutil/trace.go:171","msg":"trace[839788087] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"146.426048ms","start":"2026-09-19T01:07:41.830067Z","end":"2026-09-19T01:07:41.976493Z","steps":["trace[839788087] 'process raft request' (duration: 146.372248ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:41.97652Z","caller":"traceutil/trace.go:171","msg":"trace[22016491] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"524.719445ms","start":"2026-09-19T01:07:41.451773Z","end":"2026-09-19T01:07:41.976492Z","steps":["trace[22016491] 'process raft request' (duration: 379.770132ms)","trace[22016491] 'compare' (duration: 144.530699ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:07:41.976519Z","caller":"traceutil/trace.go:171","msg":"trace[1866472253] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2204; }","duration":"484.118715ms","start":"2026-09-19T01:07:41.492372Z","end":"2026-09-19T01:07:41.97649Z","steps":["trace[1866472253] 'read index received' (duration: 36.832854ms)","trace[1866472253] 'applied index is now lower than readState.Index' (duration: 447.283191ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:07:41.976798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.425338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:07:41.976854Z","caller":"traceutil/trace.go:171","msg":"trace[1881482937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2127; }","duration":"484.505279ms","start":"2026-09-19T01:07:41.492328Z","end":"2026-09-19T01:07:41.976833Z","steps":["trace[1881482937] 'agreement among raft nodes before linearized reading' (duration: 484.435749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:41.9768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:07:41.451761Z","time spent":"524.922747ms","remote":"127.0.0.1:49058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:07:41.97689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:07:41.492313Z","time spent":"484.56889ms","remote":"127.0.0.1:48786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:07:41.977153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.586173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-19T01:07:41.977219Z","caller":"traceutil/trace.go:171","msg":"trace[1777582685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2127; }","duration":"138.686774ms","start":"2026-09-19T01:07:41.838516Z","end":"2026-09-19T01:07:41.977202Z","steps":["trace[1777582685] 'agreement among raft nodes before linearized reading' (duration: 138.509352ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:04.513207Z","caller":"traceutil/trace.go:171","msg":"trace[897702783] linearizableReadLoop","detail":"{readStateIndex:2767; appliedIndex:2766; }","duration":"164.661781ms","start":"2026-09-19T01:09:04.348519Z","end":"2026-09-19T01:09:04.513181Z","steps":["trace[897702783] 'read index received' (duration: 164.428211ms)","trace[897702783] 'applied index is now lower than readState.Index' (duration: 232.48µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:04.51346Z","caller":"traceutil/trace.go:171","msg":"trace[1502037819] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"239.960897ms","start":"2026-09-19T01:09:04.273488Z","end":"2026-09-19T01:09:04.513449Z","steps":["trace[1502037819] 'process raft request' (duration: 239.53378ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:04.513777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.244692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-19T01:09:04.513814Z","caller":"traceutil/trace.go:171","msg":"trace[1264835822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2667; }","duration":"165.348236ms","start":"2026-09-19T01:09:04.348457Z","end":"2026-09-19T01:09:04.513805Z","steps":["trace[1264835822] 'agreement among raft nodes before linearized reading' (duration: 165.17385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:04.513981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.023366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-19T01:09:04.514007Z","caller":"traceutil/trace.go:171","msg":"trace[1990971618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2667; }","duration":"159.102588ms","start":"2026-09-19T01:09:04.354898Z","end":"2026-09-19T01:09:04.514001Z","steps":["trace[1990971618] 'agreement among raft nodes before linearized reading' (duration: 159.015884ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:39.198292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.997497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:09:39.198403Z","caller":"traceutil/trace.go:171","msg":"trace[211813571] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2863; }","duration":"123.171672ms","start":"2026-09-19T01:09:39.075212Z","end":"2026-09-19T01:09:39.198384Z","steps":["trace[211813571] 'count revisions from in-memory index tree' (duration: 122.878083ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:05.231726Z","caller":"traceutil/trace.go:171","msg":"trace[1838031359] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"131.996382ms","start":"2026-09-19T01:14:05.099702Z","end":"2026-09-19T01:14:05.231698Z","steps":["trace[1838031359] 'process raft request' (duration: 131.82011ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:06.295647Z","caller":"traceutil/trace.go:171","msg":"trace[956843344] linearizableReadLoop","detail":"{readStateIndex:5161; appliedIndex:5160; }","duration":"128.646676ms","start":"2026-09-19T01:14:06.166979Z","end":"2026-09-19T01:14:06.295625Z","steps":["trace[956843344] 'read index received' (duration: 128.427692ms)","trace[956843344] 'applied index is now lower than readState.Index' (duration: 218.054µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:14:06.295815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.816939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-19T01:14:06.295855Z","caller":"traceutil/trace.go:171","msg":"trace[1486229878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4970; }","duration":"128.8913ms","start":"2026-09-19T01:14:06.166951Z","end":"2026-09-19T01:14:06.295842Z","steps":["trace[1486229878] 'agreement among raft nodes before linearized reading' (duration: 128.757738ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:06.295961Z","caller":"traceutil/trace.go:171","msg":"trace[251046717] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"140.732631ms","start":"2026-09-19T01:14:06.1552Z","end":"2026-09-19T01:14:06.295933Z","steps":["trace[251046717] 'process raft request' (duration: 140.279234ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:12.162686Z","caller":"traceutil/trace.go:171","msg":"trace[945151499] linearizableReadLoop","detail":"{readStateIndex:5208; appliedIndex:5207; }","duration":"114.555808ms","start":"2026-09-19T01:14:12.048102Z","end":"2026-09-19T01:14:12.162658Z","steps":["trace[945151499] 'read index received' (duration: 114.320015ms)","trace[945151499] 'applied index is now lower than readState.Index' (duration: 234.483µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:14:12.162743Z","caller":"traceutil/trace.go:171","msg":"trace[1403127483] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"178.365076ms","start":"2026-09-19T01:14:11.984352Z","end":"2026-09-19T01:14:12.162717Z","steps":["trace[1403127483] 'process raft request' (duration: 178.093292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:14:12.162937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.812702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-19T01:14:12.162994Z","caller":"traceutil/trace.go:171","msg":"trace[1244163274] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5015; }","duration":"114.887753ms","start":"2026-09-19T01:14:12.048089Z","end":"2026-09-19T01:14:12.162977Z","steps":["trace[1244163274] 'agreement among raft nodes before linearized reading' (duration: 114.709291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:14:12.242021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.859069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:14:12.242059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.797791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:14:12.242082Z","caller":"traceutil/trace.go:171","msg":"trace[808919846] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:5015; }","duration":"125.948711ms","start":"2026-09-19T01:14:12.116116Z","end":"2026-09-19T01:14:12.242064Z","steps":["trace[808919846] 'agreement among raft nodes before linearized reading' (duration: 125.850309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:14:12.242338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.207122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-19T01:14:12.242389Z","caller":"traceutil/trace.go:171","msg":"trace[618182776] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5015; }","duration":"155.179826ms","start":"2026-09-19T01:14:12.087188Z","end":"2026-09-19T01:14:12.242368Z","steps":["trace[618182776] 'agreement among raft nodes before linearized reading' (duration: 154.796251ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:12.242489Z","caller":"traceutil/trace.go:171","msg":"trace[890297376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5015; }","duration":"161.403046ms","start":"2026-09-19T01:14:12.081061Z","end":"2026-09-19T01:14:12.242464Z","steps":["trace[890297376] 'agreement among raft nodes before linearized reading' (duration: 160.939568ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:12.445628Z","caller":"traceutil/trace.go:171","msg":"trace[492340392] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"103.581353ms","start":"2026-09-19T01:14:12.342025Z","end":"2026-09-19T01:14:12.445606Z","steps":["trace[492340392] 'compare' (duration: 97.128ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:12.540968Z","caller":"traceutil/trace.go:171","msg":"trace[1556256888] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5217; }","duration":"189.433723ms","start":"2026-09-19T01:14:12.351514Z","end":"2026-09-19T01:14:12.540947Z","steps":["trace[1556256888] 'read index received' (duration: 189.24366ms)","trace[1556256888] 'applied index is now lower than readState.Index' (duration: 189.093µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:14:12.541097Z","caller":"traceutil/trace.go:171","msg":"trace[506512561] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"195.514219ms","start":"2026-09-19T01:14:12.345564Z","end":"2026-09-19T01:14:12.541079Z","steps":["trace[506512561] 'process raft request' (duration: 195.240225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:14:12.541324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.794419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-19T01:14:12.541368Z","caller":"traceutil/trace.go:171","msg":"trace[2071927029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5024; }","duration":"189.87422ms","start":"2026-09-19T01:14:12.351484Z","end":"2026-09-19T01:14:12.541359Z","steps":["trace[2071927029] 'agreement among raft nodes before linearized reading' (duration: 189.729888ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:15.259227Z","caller":"traceutil/trace.go:171","msg":"trace[2129633246] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"132.855643ms","start":"2026-09-19T01:14:15.12635Z","end":"2026-09-19T01:14:15.259206Z","steps":["trace[2129633246] 'process raft request' (duration: 132.68629ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:25.35179Z","caller":"traceutil/trace.go:171","msg":"trace[1134566270] linearizableReadLoop","detail":"{readStateIndex:5444; appliedIndex:5443; }","duration":"146.519218ms","start":"2026-09-19T01:14:25.205245Z","end":"2026-09-19T01:14:25.351764Z","steps":["trace[1134566270] 'read index received' (duration: 146.369365ms)","trace[1134566270] 'applied index is now lower than readState.Index' (duration: 148.913µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:14:25.351816Z","caller":"traceutil/trace.go:171","msg":"trace[1951679173] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"209.834255ms","start":"2026-09-19T01:14:25.14196Z","end":"2026-09-19T01:14:25.351794Z","steps":["trace[1951679173] 'process raft request' (duration: 209.659572ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:14:25.351969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.716411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T01:14:25.352021Z","caller":"traceutil/trace.go:171","msg":"trace[1321649008] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5245; }","duration":"146.804461ms","start":"2026-09-19T01:14:25.20519Z","end":"2026-09-19T01:14:25.351995Z","steps":["trace[1321649008] 'agreement among raft nodes before linearized reading' (duration: 146.669599ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:14:33.741948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2830} {"level":"info","ts":"2026-09-19T01:14:33.824954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2830,"took":"81.787239ms","hash":1278063295,"current-db-size-bytes":52551680,"current-db-size":"53 MB","current-db-size-in-use-bytes":27361280,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-19T01:14:33.825028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1278063295,"revision":2830,"compact-revision":-1} {"level":"info","ts":"2026-09-19T01:19:33.74927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5307} {"level":"info","ts":"2026-09-19T01:19:33.875355Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5307,"took":"124.575696ms","hash":3333487885,"current-db-size-bytes":52551680,"current-db-size":"53 MB","current-db-size-in-use-bytes":18911232,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T01:19:33.875419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3333487885,"revision":5307,"compact-revision":2830}