{"level":"warn","ts":"2026-07-26T18:30:32.589783Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T18:30:32.58988Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.222: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.222:2380","--initial-cluster=instance=https://162.253.55.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.222: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-07-26T18:30:32.589948Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T18:30:32.58997Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T18:30:32.589992Z","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-07-26T18:30:32.59071Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"]} {"level":"info","ts":"2026-07-26T18:30:32.590887Z","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":16,"max-cpu-available":16,"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.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.222: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-07-26T18:30:32.593924Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.463772ms"} {"level":"info","ts":"2026-07-26T18:30:32.599977Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5a9e84e0e0a90b63","cluster-id":"c7ddd50204a2b828"} {"level":"info","ts":"2026-07-26T18:30:32.600045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=()"} {"level":"info","ts":"2026-07-26T18:30:32.600072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 0"} {"level":"info","ts":"2026-07-26T18:30:32.600085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5a9e84e0e0a90b63 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-26T18:30:32.600094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 1"} {"level":"info","ts":"2026-07-26T18:30:32.600134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"warn","ts":"2026-07-26T18:30:32.605907Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-26T18:30:32.609351Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-26T18:30:32.611145Z","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-07-26T18:30:32.613348Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5a9e84e0e0a90b63","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-26T18:30:32.613647Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5a9e84e0e0a90b63","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-26T18:30:32.613839Z","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-07-26T18:30:32.613964Z","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-07-26T18:30:32.613984Z","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-07-26T18:30:32.615114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"info","ts":"2026-07-26T18:30:32.615256Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","added-peer-id":"5a9e84e0e0a90b63","added-peer-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T18:30:32.61628Z","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-07-26T18:30:32.616481Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T18:30:32.616536Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T18:30:32.616517Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5a9e84e0e0a90b63","initial-advertise-peer-urls":["https://162.253.55.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-26T18:30:32.616561Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-26T18:30:33.400433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 is starting a new election at term 1"} {"level":"info","ts":"2026-07-26T18:30:33.400504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-26T18:30:33.400544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgPreVoteResp from 5a9e84e0e0a90b63 at term 1"} {"level":"info","ts":"2026-07-26T18:30:33.400566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became candidate at term 2"} {"level":"info","ts":"2026-07-26T18:30:33.400578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgVoteResp from 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T18:30:33.400608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became leader at term 2"} {"level":"info","ts":"2026-07-26T18:30:33.400622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a9e84e0e0a90b63 elected leader 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T18:30:33.402216Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T18:30:33.402221Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5a9e84e0e0a90b63","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.222:2379]}","request-path":"/0/members/5a9e84e0e0a90b63/attributes","cluster-id":"c7ddd50204a2b828","publish-timeout":"7s"} {"level":"info","ts":"2026-07-26T18:30:33.402234Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T18:30:33.402348Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T18:30:33.402615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-26T18:30:33.402649Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-26T18:30:33.403728Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T18:30:33.403952Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T18:30:33.403982Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-26T18:30:33.404005Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T18:30:33.405689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.222:2379"} {"level":"info","ts":"2026-07-26T18:31:18.689775Z","caller":"traceutil/trace.go:171","msg":"trace[1294884986] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"182.517339ms","start":"2026-07-26T18:31:18.507232Z","end":"2026-07-26T18:31:18.689749Z","steps":["trace[1294884986] 'process raft request' (duration: 182.034649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:31:19.177546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.885158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-26T18:31:19.177701Z","caller":"traceutil/trace.go:171","msg":"trace[1083122069] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"180.211628ms","start":"2026-07-26T18:31:18.997478Z","end":"2026-07-26T18:31:19.17769Z","steps":["trace[1083122069] 'process raft request' (duration: 180.144307ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:31:19.177805Z","caller":"traceutil/trace.go:171","msg":"trace[571772934] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"432.945456ms","start":"2026-07-26T18:31:18.744813Z","end":"2026-07-26T18:31:19.177759Z","steps":["trace[571772934] 'process raft request' (duration: 242.290301ms)","trace[571772934] 'compare' (duration: 189.739215ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:31:19.177801Z","caller":"traceutil/trace.go:171","msg":"trace[271636469] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"315.067466ms","start":"2026-07-26T18:31:18.86267Z","end":"2026-07-26T18:31:19.177737Z","steps":["trace[271636469] 'read index received' (duration: 124.383351ms)","trace[271636469] 'applied index is now lower than readState.Index' (duration: 190.680465ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T18:31:19.177914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:31:18.74479Z","time spent":"433.077159ms","remote":"127.0.0.1:51198","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-07-26T18:31:19.178015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.321741ms","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-07-26T18:31:19.178066Z","caller":"traceutil/trace.go:171","msg":"trace[1933172492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"315.413354ms","start":"2026-07-26T18:31:18.862634Z","end":"2026-07-26T18:31:19.178047Z","steps":["trace[1933172492] 'agreement among raft nodes before linearized reading' (duration: 315.22418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:31:19.178097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:31:18.86262Z","time spent":"315.467945ms","remote":"127.0.0.1:51094","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-07-26T18:31:34.354877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.114229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T18:31:34.354989Z","caller":"traceutil/trace.go:171","msg":"trace[35735528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"255.280723ms","start":"2026-07-26T18:31:34.099688Z","end":"2026-07-26T18:31:34.354968Z","steps":["trace[35735528] 'range keys from in-memory index tree' (duration: 255.012677ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:32:09.490316Z","caller":"traceutil/trace.go:171","msg":"trace[1673696050] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"110.877288ms","start":"2026-07-26T18:32:09.379414Z","end":"2026-07-26T18:32:09.490292Z","steps":["trace[1673696050] 'process raft request' (duration: 110.668604ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:32:17.864395Z","caller":"traceutil/trace.go:171","msg":"trace[1327982275] linearizableReadLoop","detail":"{readStateIndex:1549; appliedIndex:1548; }","duration":"320.882078ms","start":"2026-07-26T18:32:17.543487Z","end":"2026-07-26T18:32:17.864369Z","steps":["trace[1327982275] 'read index received' (duration: 320.729455ms)","trace[1327982275] 'applied index is now lower than readState.Index' (duration: 151.293µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:32:17.864528Z","caller":"traceutil/trace.go:171","msg":"trace[1574517982] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"323.058984ms","start":"2026-07-26T18:32:17.541422Z","end":"2026-07-26T18:32:17.864481Z","steps":["trace[1574517982] 'process raft request' (duration: 322.785848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:32:17.864673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.178375ms","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-07-26T18:32:17.864731Z","caller":"traceutil/trace.go:171","msg":"trace[739087187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1499; }","duration":"321.305287ms","start":"2026-07-26T18:32:17.54341Z","end":"2026-07-26T18:32:17.864715Z","steps":["trace[739087187] 'agreement among raft nodes before linearized reading' (duration: 321.144864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:32:17.864772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:32:17.543379Z","time spent":"321.384778ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-26T18:32:17.865013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:32:17.541412Z","time spent":"323.229048ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T18:32:17.868231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.674166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T18:32:17.868351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.105017ms","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-07-26T18:32:17.868349Z","caller":"traceutil/trace.go:171","msg":"trace[1052651632] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1500; }","duration":"273.87787ms","start":"2026-07-26T18:32:17.594443Z","end":"2026-07-26T18:32:17.868321Z","steps":["trace[1052651632] 'agreement among raft nodes before linearized reading' (duration: 273.644445ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:32:17.868399Z","caller":"traceutil/trace.go:171","msg":"trace[655353278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1500; }","duration":"167.177829ms","start":"2026-07-26T18:32:17.70121Z","end":"2026-07-26T18:32:17.868388Z","steps":["trace[655353278] 'agreement among raft nodes before linearized reading' (duration: 167.060917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:32:17.86838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.128396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-26T18:32:17.868382Z","caller":"traceutil/trace.go:171","msg":"trace[186998829] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"119.838974ms","start":"2026-07-26T18:32:17.748476Z","end":"2026-07-26T18:32:17.868315Z","steps":["trace[186998829] 'process raft request' (duration: 119.406675ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:32:17.868503Z","caller":"traceutil/trace.go:171","msg":"trace[85989043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1500; }","duration":"115.301309ms","start":"2026-07-26T18:32:17.753171Z","end":"2026-07-26T18:32:17.868472Z","steps":["trace[85989043] 'agreement among raft nodes before linearized reading' (duration: 114.987173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:32:28.112471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.233639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T18:32:28.112596Z","caller":"traceutil/trace.go:171","msg":"trace[1500743404] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1822; }","duration":"102.395942ms","start":"2026-07-26T18:32:28.010178Z","end":"2026-07-26T18:32:28.112574Z","steps":["trace[1500743404] 'count revisions from in-memory index tree' (duration: 102.071935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:32:33.306063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.103248ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T18:32:33.306304Z","caller":"traceutil/trace.go:171","msg":"trace[389050525] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1980; }","duration":"107.360003ms","start":"2026-07-26T18:32:33.198895Z","end":"2026-07-26T18:32:33.306255Z","steps":["trace[389050525] 'range keys from in-memory index tree' (duration: 107.079308ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:32:33.306205Z","caller":"traceutil/trace.go:171","msg":"trace[765568397] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"128.190998ms","start":"2026-07-26T18:32:33.177955Z","end":"2026-07-26T18:32:33.306145Z","steps":["trace[765568397] 'process raft request' (duration: 34.634591ms)","trace[765568397] 'compare' (duration: 93.402264ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:33:10.1721Z","caller":"traceutil/trace.go:171","msg":"trace[1869262519] linearizableReadLoop","detail":"{readStateIndex:2328; appliedIndex:2327; }","duration":"101.83773ms","start":"2026-07-26T18:33:10.070242Z","end":"2026-07-26T18:33:10.17208Z","steps":["trace[1869262519] 'read index received' (duration: 101.623415ms)","trace[1869262519] 'applied index is now lower than readState.Index' (duration: 213.115µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:33:10.172224Z","caller":"traceutil/trace.go:171","msg":"trace[563269237] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"104.825873ms","start":"2026-07-26T18:33:10.067357Z","end":"2026-07-26T18:33:10.172182Z","steps":["trace[563269237] 'process raft request' (duration: 104.589978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:33:10.172271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.012234ms","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-07-26T18:33:10.172322Z","caller":"traceutil/trace.go:171","msg":"trace[1203879923] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2236; }","duration":"102.127226ms","start":"2026-07-26T18:33:10.070179Z","end":"2026-07-26T18:33:10.172306Z","steps":["trace[1203879923] 'agreement among raft nodes before linearized reading' (duration: 102.040754ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:10.28222Z","caller":"traceutil/trace.go:171","msg":"trace[710009971] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"105.231979ms","start":"2026-07-26T18:33:10.176933Z","end":"2026-07-26T18:33:10.282165Z","steps":["trace[710009971] 'process raft request' (duration: 105.145407ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:10.282249Z","caller":"traceutil/trace.go:171","msg":"trace[636094229] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"105.592917ms","start":"2026-07-26T18:33:10.176626Z","end":"2026-07-26T18:33:10.282219Z","steps":["trace[636094229] 'process raft request' (duration: 105.297401ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:10.282429Z","caller":"traceutil/trace.go:171","msg":"trace[453234223] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"105.190518ms","start":"2026-07-26T18:33:10.17717Z","end":"2026-07-26T18:33:10.28236Z","steps":["trace[453234223] 'process raft request' (duration: 104.946803ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:10.570469Z","caller":"traceutil/trace.go:171","msg":"trace[2014807898] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"100.551463ms","start":"2026-07-26T18:33:10.469886Z","end":"2026-07-26T18:33:10.570438Z","steps":["trace[2014807898] 'process raft request' (duration: 100.363299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:33:16.453361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.239227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T18:33:16.453478Z","caller":"traceutil/trace.go:171","msg":"trace[1201656028] linearizableReadLoop","detail":"{readStateIndex:2369; appliedIndex:2368; }","duration":"146.762144ms","start":"2026-07-26T18:33:16.306698Z","end":"2026-07-26T18:33:16.45346Z","steps":["trace[1201656028] 'read index received' (duration: 20.289812ms)","trace[1201656028] 'applied index is now lower than readState.Index' (duration: 126.471042ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:33:16.453512Z","caller":"traceutil/trace.go:171","msg":"trace[85369223] transaction","detail":"{read_only:false; response_revision:2276; number_of_response:1; }","duration":"203.303192ms","start":"2026-07-26T18:33:16.250179Z","end":"2026-07-26T18:33:16.453482Z","steps":["trace[85369223] 'process raft request' (duration: 76.85278ms)","trace[85369223] 'compare' (duration: 126.114745ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T18:33:16.453664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.955598ms","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-07-26T18:33:16.453726Z","caller":"traceutil/trace.go:171","msg":"trace[136332138] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2276; }","duration":"147.111591ms","start":"2026-07-26T18:33:16.306601Z","end":"2026-07-26T18:33:16.453712Z","steps":["trace[136332138] 'agreement among raft nodes before linearized reading' (duration: 146.949678ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:33:16.453979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.57689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-26T18:33:16.45403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.938167ms","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-07-26T18:33:16.454072Z","caller":"traceutil/trace.go:171","msg":"trace[545635431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2276; }","duration":"145.020799ms","start":"2026-07-26T18:33:16.30904Z","end":"2026-07-26T18:33:16.454061Z","steps":["trace[545635431] 'agreement among raft nodes before linearized reading' (duration: 144.822724ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:16.454072Z","caller":"traceutil/trace.go:171","msg":"trace[811180142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2276; }","duration":"146.715103ms","start":"2026-07-26T18:33:16.307333Z","end":"2026-07-26T18:33:16.454048Z","steps":["trace[811180142] 'agreement among raft nodes before linearized reading' (duration: 146.448058ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:33:22.365704Z","caller":"traceutil/trace.go:171","msg":"trace[1405253968] linearizableReadLoop","detail":"{readStateIndex:2401; appliedIndex:2400; }","duration":"101.494687ms","start":"2026-07-26T18:33:22.264167Z","end":"2026-07-26T18:33:22.365662Z","steps":["trace[1405253968] 'read index received' (duration: 101.037368ms)","trace[1405253968] 'applied index is now lower than readState.Index' (duration: 455.419µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:33:22.365777Z","caller":"traceutil/trace.go:171","msg":"trace[521855535] transaction","detail":"{read_only:false; response_revision:2306; number_of_response:1; }","duration":"136.537599ms","start":"2026-07-26T18:33:22.229206Z","end":"2026-07-26T18:33:22.365743Z","steps":["trace[521855535] 'process raft request' (duration: 136.15517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:33:22.366121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.901128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-26T18:33:22.366227Z","caller":"traceutil/trace.go:171","msg":"trace[9845181] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2306; }","duration":"102.03878ms","start":"2026-07-26T18:33:22.264136Z","end":"2026-07-26T18:33:22.366175Z","steps":["trace[9845181] 'agreement among raft nodes before linearized reading' (duration: 101.712253ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:34:15.441475Z","caller":"traceutil/trace.go:171","msg":"trace[489164295] linearizableReadLoop","detail":"{readStateIndex:2806; appliedIndex:2805; }","duration":"103.975349ms","start":"2026-07-26T18:34:15.337473Z","end":"2026-07-26T18:34:15.441448Z","steps":["trace[489164295] 'read index received' (duration: 103.846646ms)","trace[489164295] 'applied index is now lower than readState.Index' (duration: 126.883µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:34:15.441558Z","caller":"traceutil/trace.go:171","msg":"trace[133941277] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"117.711676ms","start":"2026-07-26T18:34:15.323796Z","end":"2026-07-26T18:34:15.441508Z","steps":["trace[133941277] 'process raft request' (duration: 117.495232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:15.441809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.299515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-26T18:34:15.441923Z","caller":"traceutil/trace.go:171","msg":"trace[1332694696] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2699; }","duration":"104.49102ms","start":"2026-07-26T18:34:15.337409Z","end":"2026-07-26T18:34:15.4419Z","steps":["trace[1332694696] 'agreement among raft nodes before linearized reading' (duration: 104.173674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:15.494611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.885641ms","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-07-26T18:34:15.494679Z","caller":"traceutil/trace.go:171","msg":"trace[1408376686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2700; }","duration":"153.012404ms","start":"2026-07-26T18:34:15.341652Z","end":"2026-07-26T18:34:15.494664Z","steps":["trace[1408376686] 'agreement among raft nodes before linearized reading' (duration: 152.8415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:15.49479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.068893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-da9a24df-78f3-4e9d-a260-f1148b708b50\" ","response":"range_response_count:1 size:3939"} {"level":"info","ts":"2026-07-26T18:34:15.494862Z","caller":"traceutil/trace.go:171","msg":"trace[2090855084] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-da9a24df-78f3-4e9d-a260-f1148b708b50; range_end:; response_count:1; response_revision:2700; }","duration":"129.213436ms","start":"2026-07-26T18:34:15.365632Z","end":"2026-07-26T18:34:15.494845Z","steps":["trace[2090855084] 'agreement among raft nodes before linearized reading' (duration: 128.930431ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:34:25.640455Z","caller":"traceutil/trace.go:171","msg":"trace[93081098] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"110.896563ms","start":"2026-07-26T18:34:25.52954Z","end":"2026-07-26T18:34:25.640436Z","steps":["trace[93081098] 'process raft request' (duration: 110.628547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:26.017824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.164092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T18:34:26.018142Z","caller":"traceutil/trace.go:171","msg":"trace[1795971396] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"315.283216ms","start":"2026-07-26T18:34:25.702834Z","end":"2026-07-26T18:34:26.018117Z","steps":["trace[1795971396] 'process raft request' (duration: 315.120442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:26.018261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:34:25.702814Z","time spent":"315.381297ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T18:34:26.018289Z","caller":"traceutil/trace.go:171","msg":"trace[1450025546] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"315.398328ms","start":"2026-07-26T18:34:25.70275Z","end":"2026-07-26T18:34:26.018148Z","steps":["trace[1450025546] 'process raft request' (duration: 92.698085ms)","trace[1450025546] 'compare' (duration: 221.926417ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:34:26.018418Z","caller":"traceutil/trace.go:171","msg":"trace[128463498] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"311.799665ms","start":"2026-07-26T18:34:25.706562Z","end":"2026-07-26T18:34:26.018361Z","steps":["trace[128463498] 'process raft request' (duration: 311.505028ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:34:26.018682Z","caller":"traceutil/trace.go:171","msg":"trace[860418409] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"312.049809ms","start":"2026-07-26T18:34:25.706594Z","end":"2026-07-26T18:34:26.018644Z","steps":["trace[860418409] 'process raft request' (duration: 311.6495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:26.019184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:34:25.706551Z","time spent":"312.490628ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T18:34:26.01923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:34:25.706579Z","time spent":"312.577961ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T18:34:26.018779Z","caller":"traceutil/trace.go:171","msg":"trace[593669364] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"261.97913ms","start":"2026-07-26T18:34:25.756733Z","end":"2026-07-26T18:34:26.018712Z","steps":["trace[593669364] 'process raft request' (duration: 261.825597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:34:26.019823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:34:25.702718Z","time spent":"316.256926ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T18:40:33.433628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3163} {"level":"info","ts":"2026-07-26T18:40:33.522534Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3163,"took":"87.261369ms","hash":2400506689,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":13033472,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-26T18:40:33.522613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2400506689,"revision":3163,"compact-revision":-1} {"level":"info","ts":"2026-07-26T18:45:33.439801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5373} {"level":"info","ts":"2026-07-26T18:45:33.501299Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5373,"took":"58.970797ms","hash":3725779929,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":20856832,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-07-26T18:45:33.501445Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3725779929,"revision":5373,"compact-revision":3163} {"level":"info","ts":"2026-07-26T18:48:02.854789Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5a9e84e0e0a90b63","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T18:48:02.860385Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-26T18:48:02.860643Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-26T18:50:33.450562Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8427} {"level":"info","ts":"2026-07-26T18:50:33.535291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8427,"took":"81.491397ms","hash":3947753736,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":20033536,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-07-26T18:50:33.535377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3947753736,"revision":8427,"compact-revision":5373} {"level":"info","ts":"2026-07-26T18:50:41.642723Z","caller":"traceutil/trace.go:171","msg":"trace[1259059288] transaction","detail":"{read_only:false; response_revision:10750; number_of_response:1; }","duration":"151.371908ms","start":"2026-07-26T18:50:41.491329Z","end":"2026-07-26T18:50:41.642701Z","steps":["trace[1259059288] 'process raft request' (duration: 151.208795ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:50:41.644643Z","caller":"traceutil/trace.go:171","msg":"trace[1700629245] transaction","detail":"{read_only:false; response_revision:10751; number_of_response:1; }","duration":"151.849368ms","start":"2026-07-26T18:50:41.492771Z","end":"2026-07-26T18:50:41.64462Z","steps":["trace[1700629245] 'process raft request' (duration: 150.512831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:50:41.819755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.014482ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-26T18:50:41.819879Z","caller":"traceutil/trace.go:171","msg":"trace[783688139] linearizableReadLoop","detail":"{readStateIndex:11108; appliedIndex:11106; }","duration":"300.166293ms","start":"2026-07-26T18:50:41.519694Z","end":"2026-07-26T18:50:41.81986Z","steps":["trace[783688139] 'read index received' (duration: 122.871075ms)","trace[783688139] 'applied index is now lower than readState.Index' (duration: 177.293578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T18:50:41.820101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.814711ms","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":"warn","ts":"2026-07-26T18:50:41.820135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.447549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-q8x66\" ","response":"range_response_count:1 size:9709"} {"level":"info","ts":"2026-07-26T18:50:41.820156Z","caller":"traceutil/trace.go:171","msg":"trace[930231560] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-q8x66; range_end:; response_count:1; response_revision:10752; }","duration":"300.502269ms","start":"2026-07-26T18:50:41.519646Z","end":"2026-07-26T18:50:41.820149Z","steps":["trace[930231560] 'agreement among raft nodes before linearized reading' (duration: 300.330836ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:50:41.820163Z","caller":"traceutil/trace.go:171","msg":"trace[2015283660] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:10752; }","duration":"182.943953ms","start":"2026-07-26T18:50:41.637199Z","end":"2026-07-26T18:50:41.820142Z","steps":["trace[2015283660] 'agreement among raft nodes before linearized reading' (duration: 182.79527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:50:41.820207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:50:41.519628Z","time spent":"300.572592ms","remote":"127.0.0.1:51028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9732,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-q8x66\" "} {"level":"info","ts":"2026-07-26T18:52:41.813947Z","caller":"traceutil/trace.go:171","msg":"trace[499923186] transaction","detail":"{read_only:false; response_revision:11717; number_of_response:1; }","duration":"108.425299ms","start":"2026-07-26T18:52:41.705482Z","end":"2026-07-26T18:52:41.813908Z","steps":["trace[499923186] 'process raft request' (duration: 108.181444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.113928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.75577ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-26T18:52:42.114082Z","caller":"traceutil/trace.go:171","msg":"trace[1051905385] linearizableReadLoop","detail":"{readStateIndex:12117; appliedIndex:12115; }","duration":"359.548498ms","start":"2026-07-26T18:52:41.754507Z","end":"2026-07-26T18:52:42.114056Z","steps":["trace[1051905385] 'read index received' (duration: 59.11538ms)","trace[1051905385] 'applied index is now lower than readState.Index' (duration: 300.430488ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T18:52:42.11443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.913375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-26T18:52:42.114484Z","caller":"traceutil/trace.go:171","msg":"trace[1174842546] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11717; }","duration":"360.032267ms","start":"2026-07-26T18:52:41.754438Z","end":"2026-07-26T18:52:42.11447Z","steps":["trace[1174842546] 'agreement among raft nodes before linearized reading' (duration: 359.750291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.114535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T18:52:41.754413Z","time spent":"360.108848ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-26T18:52:42.114528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.556587ms","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-07-26T18:52:42.114621Z","caller":"traceutil/trace.go:171","msg":"trace[1488560332] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:11717; }","duration":"143.69246ms","start":"2026-07-26T18:52:41.970909Z","end":"2026-07-26T18:52:42.114601Z","steps":["trace[1488560332] 'agreement among raft nodes before linearized reading' (duration: 143.537837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.114791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.668219ms","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":"warn","ts":"2026-07-26T18:52:42.114808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.421198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T18:52:42.114858Z","caller":"traceutil/trace.go:171","msg":"trace[363314162] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:11717; }","duration":"228.746932ms","start":"2026-07-26T18:52:41.886096Z","end":"2026-07-26T18:52:42.114843Z","steps":["trace[363314162] 'agreement among raft nodes before linearized reading' (duration: 228.630728ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:52:42.114931Z","caller":"traceutil/trace.go:171","msg":"trace[776122879] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:11717; }","duration":"217.563202ms","start":"2026-07-26T18:52:41.897313Z","end":"2026-07-26T18:52:42.114876Z","steps":["trace[776122879] 'agreement among raft nodes before linearized reading' (duration: 217.375627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.1148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.130383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T18:52:42.115458Z","caller":"traceutil/trace.go:171","msg":"trace[874953069] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:11717; }","duration":"284.883899ms","start":"2026-07-26T18:52:41.830551Z","end":"2026-07-26T18:52:42.115435Z","steps":["trace[874953069] 'agreement among raft nodes before linearized reading' (duration: 283.815067ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:52:42.223986Z","caller":"traceutil/trace.go:171","msg":"trace[1131305540] transaction","detail":"{read_only:false; response_revision:11718; number_of_response:1; }","duration":"103.542808ms","start":"2026-07-26T18:52:42.120412Z","end":"2026-07-26T18:52:42.223955Z","steps":["trace[1131305540] 'process raft request' (duration: 103.362714ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:52:42.286284Z","caller":"traceutil/trace.go:171","msg":"trace[1995441940] transaction","detail":"{read_only:false; response_revision:11719; number_of_response:1; }","duration":"161.668429ms","start":"2026-07-26T18:52:42.124582Z","end":"2026-07-26T18:52:42.286251Z","steps":["trace[1995441940] 'process raft request' (duration: 161.442104ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:52:42.882582Z","caller":"traceutil/trace.go:171","msg":"trace[1288387248] linearizableReadLoop","detail":"{readStateIndex:12122; appliedIndex:12121; }","duration":"109.387948ms","start":"2026-07-26T18:52:42.773166Z","end":"2026-07-26T18:52:42.882554Z","steps":["trace[1288387248] 'read index received' (duration: 109.183943ms)","trace[1288387248] 'applied index is now lower than readState.Index' (duration: 202.235µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T18:52:42.882874Z","caller":"traceutil/trace.go:171","msg":"trace[898709061] transaction","detail":"{read_only:false; response_revision:11722; number_of_response:1; }","duration":"124.04329ms","start":"2026-07-26T18:52:42.758782Z","end":"2026-07-26T18:52:42.882825Z","steps":["trace[898709061] 'process raft request' (duration: 123.570459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.88302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.840287ms","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-07-26T18:52:42.883602Z","caller":"traceutil/trace.go:171","msg":"trace[1590768220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11722; }","duration":"110.472701ms","start":"2026-07-26T18:52:42.77311Z","end":"2026-07-26T18:52:42.883583Z","steps":["trace[1590768220] 'agreement among raft nodes before linearized reading' (duration: 109.686905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.883159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.969439ms","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-07-26T18:52:42.883752Z","caller":"traceutil/trace.go:171","msg":"trace[257611400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11722; }","duration":"107.582761ms","start":"2026-07-26T18:52:42.776144Z","end":"2026-07-26T18:52:42.883727Z","steps":["trace[257611400] 'agreement among raft nodes before linearized reading' (duration: 106.954918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T18:52:42.883345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.706561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-26T18:52:42.883836Z","caller":"traceutil/trace.go:171","msg":"trace[728559159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11722; }","duration":"102.263052ms","start":"2026-07-26T18:52:42.781547Z","end":"2026-07-26T18:52:42.883811Z","steps":["trace[728559159] 'agreement among raft nodes before linearized reading' (duration: 101.590379ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T18:55:33.45717Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10688} {"level":"info","ts":"2026-07-26T18:55:33.534391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10688,"took":"74.290191ms","hash":1721237703,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":19431424,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-26T18:55:33.534471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1721237703,"revision":10688,"compact-revision":8427} {"level":"info","ts":"2026-07-26T19:00:33.463647Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13023} {"level":"info","ts":"2026-07-26T19:00:33.557049Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13023,"took":"90.189388ms","hash":1818892155,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":15200256,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T19:00:33.557131Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1818892155,"revision":13023,"compact-revision":10688} {"level":"info","ts":"2026-07-26T19:05:33.471925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14699} {"level":"info","ts":"2026-07-26T19:05:33.539464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14699,"took":"64.261209ms","hash":1827554639,"current-db-size-bytes":41119744,"current-db-size":"41 MB","current-db-size-in-use-bytes":16031744,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-26T19:05:33.539525Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1827554639,"revision":14699,"compact-revision":13023}