{"level":"warn","ts":"2026-09-07T18:14:36.599865Z","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-07T18:14:36.600095Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.81: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.81:2380","--initial-cluster=instance=https://162.253.55.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.81: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-07T18:14:36.600239Z","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-07T18:14:36.600271Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-07T18:14:36.600302Z","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-07T18:14:36.601185Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"]} {"level":"info","ts":"2026-09-07T18:14:36.601305Z","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.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.81: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-07T18:14:36.607164Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.469438ms"} {"level":"info","ts":"2026-09-07T18:14:36.615205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d346c241c42fcdea","cluster-id":"331f16aa5aa938b6"} {"level":"info","ts":"2026-09-07T18:14:36.615303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T18:14:36.615341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 0"} {"level":"info","ts":"2026-09-07T18:14:36.615371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d346c241c42fcdea [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T18:14:36.61539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 1"} {"level":"info","ts":"2026-09-07T18:14:36.615453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"warn","ts":"2026-09-07T18:14:36.626039Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T18:14:36.627451Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T18:14:36.628813Z","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-07T18:14:36.63087Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d346c241c42fcdea","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T18:14:36.634429Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d346c241c42fcdea","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T18:14:36.634569Z","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-07T18:14:36.634619Z","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-07T18:14:36.634633Z","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-07T18:14:36.635476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"info","ts":"2026-09-07T18:14:36.635544Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-07T18:14:36.63559Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-07T18:14:36.635475Z","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-07T18:14:36.635632Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","added-peer-id":"d346c241c42fcdea","added-peer-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-07T18:14:36.635921Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d346c241c42fcdea","initial-advertise-peer-urls":["https://162.253.55.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T18:14:36.635982Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T18:14:37.120598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T18:14:37.120641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T18:14:37.12067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgPreVoteResp from d346c241c42fcdea at term 1"} {"level":"info","ts":"2026-09-07T18:14:37.120684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became candidate at term 2"} {"level":"info","ts":"2026-09-07T18:14:37.120694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgVoteResp from d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-07T18:14:37.120719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became leader at term 2"} {"level":"info","ts":"2026-09-07T18:14:37.120731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d346c241c42fcdea elected leader d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-07T18:14:37.122798Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d346c241c42fcdea","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.81:2379]}","request-path":"/0/members/d346c241c42fcdea/attributes","cluster-id":"331f16aa5aa938b6","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T18:14:37.122978Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:14:37.123507Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T18:14:37.123754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T18:14:37.12385Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:14:37.123972Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T18:14:37.124001Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:14:37.124047Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:14:37.124008Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T18:14:37.125767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T18:14:37.130107Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.81:2379"} {"level":"info","ts":"2026-09-07T18:15:00.588324Z","caller":"traceutil/trace.go:171","msg":"trace[872336236] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"146.182312ms","start":"2026-09-07T18:15:00.442117Z","end":"2026-09-07T18:15:00.588299Z","steps":["trace[872336236] 'read index received' (duration: 146.06755ms)","trace[872336236] 'applied index is now lower than readState.Index' (duration: 113.392µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:00.58854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.369684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:15:00.588638Z","caller":"traceutil/trace.go:171","msg":"trace[521887706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"146.542786ms","start":"2026-09-07T18:15:00.44208Z","end":"2026-09-07T18:15:00.588623Z","steps":["trace[521887706] 'agreement among raft nodes before linearized reading' (duration: 146.379634ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:19.453444Z","caller":"traceutil/trace.go:171","msg":"trace[1417638572] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"198.179786ms","start":"2026-09-07T18:15:19.255243Z","end":"2026-09-07T18:15:19.453423Z","steps":["trace[1417638572] 'read index received' (duration: 197.223377ms)","trace[1417638572] 'applied index is now lower than readState.Index' (duration: 955.419µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:19.45368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.406345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-07T18:15:19.453761Z","caller":"traceutil/trace.go:171","msg":"trace[182223718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"198.551692ms","start":"2026-09-07T18:15:19.255196Z","end":"2026-09-07T18:15:19.453748Z","steps":["trace[182223718] 'agreement among raft nodes before linearized reading' (duration: 198.339444ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:19.454223Z","caller":"traceutil/trace.go:171","msg":"trace[896002268] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"327.674532ms","start":"2026-09-07T18:15:19.125821Z","end":"2026-09-07T18:15:19.453496Z","steps":["trace[896002268] 'process raft request' (duration: 326.943073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:19.4549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:15:19.125785Z","time spent":"328.572949ms","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:15:19.493692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.001341ms","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-07T18:15:19.493807Z","caller":"traceutil/trace.go:171","msg":"trace[1478546940] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"141.163718ms","start":"2026-09-07T18:15:19.352624Z","end":"2026-09-07T18:15:19.493788Z","steps":["trace[1478546940] 'agreement among raft nodes before linearized reading' (duration: 140.889237ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:19.49397Z","caller":"traceutil/trace.go:171","msg":"trace[1648125503] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"223.275324ms","start":"2026-09-07T18:15:19.27062Z","end":"2026-09-07T18:15:19.493895Z","steps":["trace[1648125503] 'process raft request' (duration: 222.756813ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:20.047592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.035982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:15:20.047701Z","caller":"traceutil/trace.go:171","msg":"trace[1349928757] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"399.701642ms","start":"2026-09-07T18:15:19.647982Z","end":"2026-09-07T18:15:20.047683Z","steps":["trace[1349928757] 'read index received' (duration: 167.248994ms)","trace[1349928757] 'applied index is now lower than readState.Index' (duration: 232.451458ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:20.047844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.86163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pkpj7\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-07T18:15:20.04785Z","caller":"traceutil/trace.go:171","msg":"trace[2065530418] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"519.880942ms","start":"2026-09-07T18:15:19.527933Z","end":"2026-09-07T18:15:20.047814Z","steps":["trace[2065530418] 'process raft request' (duration: 287.37152ms)","trace[2065530418] 'compare' (duration: 231.883186ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:15:20.047876Z","caller":"traceutil/trace.go:171","msg":"trace[1495498222] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pkpj7; range_end:; response_count:1; response_revision:588; }","duration":"399.929053ms","start":"2026-09-07T18:15:19.647937Z","end":"2026-09-07T18:15:20.047866Z","steps":["trace[1495498222] 'agreement among raft nodes before linearized reading' (duration: 399.816078ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:20.047966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:15:19.647916Z","time spent":"400.038857ms","remote":"127.0.0.1:32870","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-pkpj7\" "} {"level":"warn","ts":"2026-09-07T18:15:20.048016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:15:19.527914Z","time spent":"520.021717ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:15:46.005197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.287016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:15:46.005545Z","caller":"traceutil/trace.go:171","msg":"trace[514153580] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"339.864993ms","start":"2026-09-07T18:15:45.665658Z","end":"2026-09-07T18:15:46.005523Z","steps":["trace[514153580] 'process raft request' (duration: 339.76084ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:46.005695Z","caller":"traceutil/trace.go:171","msg":"trace[1228430323] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"340.016878ms","start":"2026-09-07T18:15:45.665659Z","end":"2026-09-07T18:15:46.005676Z","steps":["trace[1228430323] 'process raft request' (duration: 199.154762ms)","trace[1228430323] 'compare' (duration: 140.08925ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:46.005776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:15:45.665641Z","time spent":"340.096169ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:15:46.005715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:15:45.665636Z","time spent":"340.022627ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T18:15:46.027225Z","caller":"traceutil/trace.go:171","msg":"trace[995988632] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:810; }","duration":"255.20182ms","start":"2026-09-07T18:15:45.772Z","end":"2026-09-07T18:15:46.027202Z","steps":["trace[995988632] 'read index received' (duration: 92.88624ms)","trace[995988632] 'applied index is now lower than readState.Index' (duration: 162.31434ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:46.027543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.123769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rskkz\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-07T18:15:46.027608Z","caller":"traceutil/trace.go:171","msg":"trace[764601186] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rskkz; range_end:; response_count:1; response_revision:782; }","duration":"233.249873ms","start":"2026-09-07T18:15:45.794339Z","end":"2026-09-07T18:15:46.027589Z","steps":["trace[764601186] 'agreement among raft nodes before linearized reading' (duration: 232.996465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:46.027676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.624173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-07T18:15:46.027797Z","caller":"traceutil/trace.go:171","msg":"trace[1471297432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"255.775279ms","start":"2026-09-07T18:15:45.771988Z","end":"2026-09-07T18:15:46.027763Z","steps":["trace[1471297432] 'agreement among raft nodes before linearized reading' (duration: 255.315614ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:07.470038Z","caller":"traceutil/trace.go:171","msg":"trace[1981925683] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"242.590424ms","start":"2026-09-07T18:17:07.227422Z","end":"2026-09-07T18:17:07.470012Z","steps":["trace[1981925683] 'process raft request' (duration: 242.346089ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:07.806311Z","caller":"traceutil/trace.go:171","msg":"trace[1163990091] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1941; }","duration":"395.136568ms","start":"2026-09-07T18:17:07.411145Z","end":"2026-09-07T18:17:07.806282Z","steps":["trace[1163990091] 'read index received' (duration: 58.690651ms)","trace[1163990091] 'applied index is now lower than readState.Index' (duration: 336.444577ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:17:07.806634Z","caller":"traceutil/trace.go:171","msg":"trace[2087948766] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"558.422133ms","start":"2026-09-07T18:17:07.248186Z","end":"2026-09-07T18:17:07.806608Z","steps":["trace[2087948766] 'process raft request' (duration: 503.857455ms)","trace[2087948766] 'compare' (duration: 54.139589ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:17:07.80703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.591449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-07T18:17:07.807071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.901904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-07T18:17:07.8071Z","caller":"traceutil/trace.go:171","msg":"trace[99829797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1869; }","duration":"368.718262ms","start":"2026-09-07T18:17:07.438366Z","end":"2026-09-07T18:17:07.807084Z","steps":["trace[99829797] 'agreement among raft nodes before linearized reading' (duration: 368.584429ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:07.807176Z","caller":"traceutil/trace.go:171","msg":"trace[120094064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1869; }","duration":"396.059677ms","start":"2026-09-07T18:17:07.411092Z","end":"2026-09-07T18:17:07.807152Z","steps":["trace[120094064] 'agreement among raft nodes before linearized reading' (duration: 395.783451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:17:07.80725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:07.41107Z","time spent":"396.15469ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-07T18:17:07.80725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:07.438345Z","time spent":"368.843355ms","remote":"127.0.0.1:60886","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-07T18:17:07.80788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:07.248156Z","time spent":"558.557655ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T18:17:56.8695Z","caller":"traceutil/trace.go:171","msg":"trace[584791159] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"140.159604ms","start":"2026-09-07T18:17:56.729319Z","end":"2026-09-07T18:17:56.869478Z","steps":["trace[584791159] 'read index received' (duration: 139.9315ms)","trace[584791159] 'applied index is now lower than readState.Index' (duration: 227.134µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:17:56.869769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.431609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-07T18:17:56.869841Z","caller":"traceutil/trace.go:171","msg":"trace[1188850654] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2183; }","duration":"140.563911ms","start":"2026-09-07T18:17:56.729264Z","end":"2026-09-07T18:17:56.869828Z","steps":["trace[1188850654] 'agreement among raft nodes before linearized reading' (duration: 140.350758ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:56.869576Z","caller":"traceutil/trace.go:171","msg":"trace[2085576040] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"146.379516ms","start":"2026-09-07T18:17:56.723163Z","end":"2026-09-07T18:17:56.869542Z","steps":["trace[2085576040] 'process raft request' (duration: 146.162363ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:57.087654Z","caller":"traceutil/trace.go:171","msg":"trace[863282714] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"213.282869ms","start":"2026-09-07T18:17:56.874347Z","end":"2026-09-07T18:17:57.087629Z","steps":["trace[863282714] 'process raft request' (duration: 132.68298ms)","trace[863282714] 'compare' (duration: 80.373704ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:17:57.312896Z","caller":"traceutil/trace.go:171","msg":"trace[553155754] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2269; }","duration":"331.32682ms","start":"2026-09-07T18:17:56.981548Z","end":"2026-09-07T18:17:57.312875Z","steps":["trace[553155754] 'read index received' (duration: 25.520886ms)","trace[553155754] 'applied index is now lower than readState.Index' (duration: 305.805004ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:17:57.313084Z","caller":"traceutil/trace.go:171","msg":"trace[2013706831] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"437.583769ms","start":"2026-09-07T18:17:56.875488Z","end":"2026-09-07T18:17:57.313072Z","steps":["trace[2013706831] 'process raft request' (duration: 437.347824ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:57.313033Z","caller":"traceutil/trace.go:171","msg":"trace[1796902312] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"438.613717ms","start":"2026-09-07T18:17:56.874371Z","end":"2026-09-07T18:17:57.312984Z","steps":["trace[1796902312] 'process raft request' (duration: 438.414763ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:57.312946Z","caller":"traceutil/trace.go:171","msg":"trace[1380273327] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"438.523015ms","start":"2026-09-07T18:17:56.874373Z","end":"2026-09-07T18:17:57.312896Z","steps":["trace[1380273327] 'process raft request' (duration: 403.784036ms)","trace[1380273327] 'compare' (duration: 34.529815ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:17:57.313295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:56.87547Z","time spent":"437.67893ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:17:57.313367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:56.874333Z","time spent":"438.959564ms","remote":"127.0.0.1:32964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:17:57.313566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.216753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-07T18:17:57.313705Z","caller":"traceutil/trace.go:171","msg":"trace[1335079396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2187; }","duration":"245.393886ms","start":"2026-09-07T18:17:57.068297Z","end":"2026-09-07T18:17:57.313691Z","steps":["trace[1335079396] 'agreement among raft nodes before linearized reading' (duration: 245.016069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:17:57.31371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.86047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:17:57.313816Z","caller":"traceutil/trace.go:171","msg":"trace[1146256770] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2187; }","duration":"332.290986ms","start":"2026-09-07T18:17:56.981501Z","end":"2026-09-07T18:17:57.313792Z","steps":["trace[1146256770] 'agreement among raft nodes before linearized reading' (duration: 331.797808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:17:57.313876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:56.981483Z","time spent":"332.377849ms","remote":"127.0.0.1:34352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-07T18:17:57.313784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:17:56.874343Z","time spent":"438.910262ms","remote":"127.0.0.1:32964","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-07T18:17:57.314083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.046266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-07T18:17:57.31415Z","caller":"traceutil/trace.go:171","msg":"trace[319285087] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2187; }","duration":"159.160608ms","start":"2026-09-07T18:17:57.154971Z","end":"2026-09-07T18:17:57.314132Z","steps":["trace[319285087] 'agreement among raft nodes before linearized reading' (duration: 158.357484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:19:15.528098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.293997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T18:19:15.528645Z","caller":"traceutil/trace.go:171","msg":"trace[1251561050] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2716; }","duration":"121.882087ms","start":"2026-09-07T18:19:15.406739Z","end":"2026-09-07T18:19:15.528621Z","steps":["trace[1251561050] 'count revisions from in-memory index tree' (duration: 121.206235ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:19:15.59681Z","caller":"traceutil/trace.go:171","msg":"trace[1452240461] linearizableReadLoop","detail":"{readStateIndex:2820; appliedIndex:2819; }","duration":"116.761062ms","start":"2026-09-07T18:19:15.480012Z","end":"2026-09-07T18:19:15.596773Z","steps":["trace[1452240461] 'read index received' (duration: 21.074995ms)","trace[1452240461] 'applied index is now lower than readState.Index' (duration: 95.684837ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:19:15.597041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.964265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T18:19:15.597131Z","caller":"traceutil/trace.go:171","msg":"trace[1978524121] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2716; }","duration":"117.14556ms","start":"2026-09-07T18:19:15.479967Z","end":"2026-09-07T18:19:15.597112Z","steps":["trace[1978524121] 'agreement among raft nodes before linearized reading' (duration: 116.928125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:19:15.59725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.143421ms","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-07T18:19:15.597386Z","caller":"traceutil/trace.go:171","msg":"trace[1576279680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2716; }","duration":"111.286414ms","start":"2026-09-07T18:19:15.486051Z","end":"2026-09-07T18:19:15.597337Z","steps":["trace[1576279680] 'agreement among raft nodes before linearized reading' (duration: 110.983098ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:43.310319Z","caller":"traceutil/trace.go:171","msg":"trace[775335298] linearizableReadLoop","detail":"{readStateIndex:4904; appliedIndex:4903; }","duration":"170.046221ms","start":"2026-09-07T18:23:43.140258Z","end":"2026-09-07T18:23:43.310305Z","steps":["trace[775335298] 'read index received' (duration: 150.811687ms)","trace[775335298] 'applied index is now lower than readState.Index' (duration: 19.233874ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:23:43.310368Z","caller":"traceutil/trace.go:171","msg":"trace[2123705079] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"176.014718ms","start":"2026-09-07T18:23:43.134331Z","end":"2026-09-07T18:23:43.310345Z","steps":["trace[2123705079] 'process raft request' (duration: 156.727563ms)","trace[2123705079] 'compare' (duration: 19.155442ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:23:43.310466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.193925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d52a105-fccc-4e8e-889b-6e385086fb35\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-07T18:23:43.310493Z","caller":"traceutil/trace.go:171","msg":"trace[1642110191] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d52a105-fccc-4e8e-889b-6e385086fb35; range_end:; response_count:1; response_revision:4722; }","duration":"170.259436ms","start":"2026-09-07T18:23:43.140226Z","end":"2026-09-07T18:23:43.310486Z","steps":["trace[1642110191] 'agreement among raft nodes before linearized reading' (duration: 170.162123ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:43.39883Z","caller":"traceutil/trace.go:171","msg":"trace[764295249] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"209.131583ms","start":"2026-09-07T18:23:43.189671Z","end":"2026-09-07T18:23:43.398803Z","steps":["trace[764295249] 'process raft request' (duration: 208.956579ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:43.432866Z","caller":"traceutil/trace.go:171","msg":"trace[1672962545] linearizableReadLoop","detail":"{readStateIndex:4906; appliedIndex:4904; }","duration":"122.475658ms","start":"2026-09-07T18:23:43.310371Z","end":"2026-09-07T18:23:43.432847Z","steps":["trace[1672962545] 'read index received' (duration: 88.233044ms)","trace[1672962545] 'applied index is now lower than readState.Index' (duration: 34.241684ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:23:43.433122Z","caller":"traceutil/trace.go:171","msg":"trace[1768437623] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"115.956058ms","start":"2026-09-07T18:23:43.317145Z","end":"2026-09-07T18:23:43.433101Z","steps":["trace[1768437623] 'process raft request' (duration: 115.645099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:43.433243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.400968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-07T18:23:43.433278Z","caller":"traceutil/trace.go:171","msg":"trace[2028370019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4725; }","duration":"290.478639ms","start":"2026-09-07T18:23:43.142791Z","end":"2026-09-07T18:23:43.43327Z","steps":["trace[2028370019] 'agreement among raft nodes before linearized reading' (duration: 290.305165ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:43.433391Z","caller":"traceutil/trace.go:171","msg":"trace[1401073347] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"123.240067ms","start":"2026-09-07T18:23:43.310081Z","end":"2026-09-07T18:23:43.433321Z","steps":["trace[1401073347] 'process raft request' (duration: 108.34848ms)","trace[1401073347] 'compare' (duration: 14.280492ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:23:43.433468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.402144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-07T18:23:43.433494Z","caller":"traceutil/trace.go:171","msg":"trace[1868940270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4725; }","duration":"266.434906ms","start":"2026-09-07T18:23:43.167053Z","end":"2026-09-07T18:23:43.433488Z","steps":["trace[1868940270] 'agreement among raft nodes before linearized reading' (duration: 266.351924ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:43.433497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.770576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T18:23:43.433622Z","caller":"traceutil/trace.go:171","msg":"trace[1415038207] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:4725; }","duration":"288.937701ms","start":"2026-09-07T18:23:43.14465Z","end":"2026-09-07T18:23:43.433588Z","steps":["trace[1415038207] 'agreement among raft nodes before linearized reading' (duration: 288.748586ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:43.433656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.490068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-09-07T18:23:43.433987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.786399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8300803f-9c51-4b74-af39-c483f4ce688c\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-09-07T18:23:43.434026Z","caller":"traceutil/trace.go:171","msg":"trace[278617113] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4725; }","duration":"264.960989ms","start":"2026-09-07T18:23:43.168785Z","end":"2026-09-07T18:23:43.433746Z","steps":["trace[278617113] 'agreement among raft nodes before linearized reading' (duration: 264.360205ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:43.434042Z","caller":"traceutil/trace.go:171","msg":"trace[186963145] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8300803f-9c51-4b74-af39-c483f4ce688c; range_end:; response_count:1; response_revision:4725; }","duration":"153.927343ms","start":"2026-09-07T18:23:43.280099Z","end":"2026-09-07T18:23:43.434026Z","steps":["trace[186963145] 'agreement among raft nodes before linearized reading' (duration: 153.090103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:47.462309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.600809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-07T18:23:47.462597Z","caller":"traceutil/trace.go:171","msg":"trace[873923422] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4825; }","duration":"101.945029ms","start":"2026-09-07T18:23:47.360629Z","end":"2026-09-07T18:23:47.462574Z","steps":["trace[873923422] 'range keys from in-memory index tree' (duration: 101.457586ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:23:53.393155Z","caller":"traceutil/trace.go:171","msg":"trace[330605862] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5121; }","duration":"195.023251ms","start":"2026-09-07T18:23:53.198109Z","end":"2026-09-07T18:23:53.393132Z","steps":["trace[330605862] 'read index received' (duration: 194.775425ms)","trace[330605862] 'applied index is now lower than readState.Index' (duration: 246.656µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:23:53.393184Z","caller":"traceutil/trace.go:171","msg":"trace[1543061677] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"221.262429ms","start":"2026-09-07T18:23:53.171892Z","end":"2026-09-07T18:23:53.393154Z","steps":["trace[1543061677] 'process raft request' (duration: 221.100965ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:53.393392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.263497ms","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-07T18:23:53.393446Z","caller":"traceutil/trace.go:171","msg":"trace[1921900559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4933; }","duration":"195.367948ms","start":"2026-09-07T18:23:53.198068Z","end":"2026-09-07T18:23:53.393436Z","steps":["trace[1921900559] 'agreement among raft nodes before linearized reading' (duration: 195.190104ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:53.393541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.839298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-86ccabed-2c7b-4131-aa48-d64d71c4c89a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-07T18:23:53.393628Z","caller":"traceutil/trace.go:171","msg":"trace[519739041] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-86ccabed-2c7b-4131-aa48-d64d71c4c89a; range_end:; response_count:1; response_revision:4933; }","duration":"149.031143ms","start":"2026-09-07T18:23:53.244574Z","end":"2026-09-07T18:23:53.393605Z","steps":["trace[519739041] 'agreement among raft nodes before linearized reading' (duration: 148.733205ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:24:01.218406Z","caller":"traceutil/trace.go:171","msg":"trace[472785541] transaction","detail":"{read_only:false; response_revision:5054; number_of_response:1; }","duration":"101.488401ms","start":"2026-09-07T18:24:01.116882Z","end":"2026-09-07T18:24:01.218371Z","steps":["trace[472785541] 'process raft request' (duration: 65.69151ms)","trace[472785541] 'compare' (duration: 35.445743ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:24:07.593578Z","caller":"traceutil/trace.go:171","msg":"trace[774725304] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"100.937431ms","start":"2026-09-07T18:24:07.492614Z","end":"2026-09-07T18:24:07.593552Z","steps":["trace[774725304] 'process raft request' (duration: 100.723316ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:24:07.593778Z","caller":"traceutil/trace.go:171","msg":"trace[1368288684] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"100.403808ms","start":"2026-09-07T18:24:07.493353Z","end":"2026-09-07T18:24:07.593757Z","steps":["trace[1368288684] 'process raft request' (duration: 100.13093ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:24:07.594228Z","caller":"traceutil/trace.go:171","msg":"trace[316065546] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"100.174123ms","start":"2026-09-07T18:24:07.494035Z","end":"2026-09-07T18:24:07.594209Z","steps":["trace[316065546] 'process raft request' (duration: 99.63661ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:24:07.594224Z","caller":"traceutil/trace.go:171","msg":"trace[64045508] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"100.113971ms","start":"2026-09-07T18:24:07.494086Z","end":"2026-09-07T18:24:07.5942Z","steps":["trace[64045508] 'process raft request' (duration: 99.990008ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:24:07.980548Z","caller":"traceutil/trace.go:171","msg":"trace[580021548] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"102.005617ms","start":"2026-09-07T18:24:07.878511Z","end":"2026-09-07T18:24:07.980517Z","steps":["trace[580021548] 'process raft request' (duration: 55.899265ms)","trace[580021548] 'compare' (duration: 45.358593ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:24:37.157729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2831} {"level":"info","ts":"2026-09-07T18:24:37.229719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2831,"took":"70.783637ms","hash":3315204605,"current-db-size-bytes":52269056,"current-db-size":"52 MB","current-db-size-in-use-bytes":27828224,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T18:24:37.229797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3315204605,"revision":2831,"compact-revision":-1} {"level":"info","ts":"2026-09-07T18:28:03.250809Z","caller":"traceutil/trace.go:171","msg":"trace[621621641] transaction","detail":"{read_only:false; response_revision:6862; number_of_response:1; }","duration":"122.777368ms","start":"2026-09-07T18:28:03.127996Z","end":"2026-09-07T18:28:03.250773Z","steps":["trace[621621641] 'process raft request' (duration: 52.936884ms)","trace[621621641] 'compare' (duration: 69.420717ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:29:37.164853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5410} {"level":"info","ts":"2026-09-07T18:29:37.246613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5410,"took":"80.056456ms","hash":2064759553,"current-db-size-bytes":52269056,"current-db-size":"52 MB","current-db-size-in-use-bytes":18513920,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-07T18:29:37.246702Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2064759553,"revision":5410,"compact-revision":2831}