{"level":"warn","ts":"2026-10-13T21:14:51.74215Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T21:14:51.742273Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.73: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.73:2380","--initial-cluster=instance=https://162.253.55.73:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.73:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.73: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-10-13T21:14:51.742362Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T21:14:51.742372Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-13T21:14:51.742392Z","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-10-13T21:14:51.744591Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"]} {"level":"info","ts":"2026-10-13T21:14:51.744711Z","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.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.73: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-10-13T21:14:51.750076Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.033069ms"} {"level":"info","ts":"2026-10-13T21:14:51.759806Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4c43c9f84c6588d4","cluster-id":"49c90045dbd991f3"} {"level":"info","ts":"2026-10-13T21:14:51.760029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T21:14:51.760102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 0"} {"level":"info","ts":"2026-10-13T21:14:51.760142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4c43c9f84c6588d4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T21:14:51.760198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 1"} {"level":"info","ts":"2026-10-13T21:14:51.760293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"warn","ts":"2026-10-13T21:14:51.767053Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T21:14:51.769114Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T21:14:51.770524Z","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-10-13T21:14:51.772584Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4c43c9f84c6588d4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T21:14:51.772751Z","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-10-13T21:14:51.772901Z","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-10-13T21:14:51.772929Z","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-10-13T21:14:51.772883Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4c43c9f84c6588d4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T21:14:51.775142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"info","ts":"2026-10-13T21:14:51.775304Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","added-peer-id":"4c43c9f84c6588d4","added-peer-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-13T21:14:51.777104Z","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-10-13T21:14:51.77727Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-13T21:14:51.777299Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-13T21:14:51.777498Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4c43c9f84c6588d4","initial-advertise-peer-urls":["https://162.253.55.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T21:14:51.777535Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T21:14:52.461363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T21:14:52.461435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T21:14:52.461487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgPreVoteResp from 4c43c9f84c6588d4 at term 1"} {"level":"info","ts":"2026-10-13T21:14:52.461512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became candidate at term 2"} {"level":"info","ts":"2026-10-13T21:14:52.461529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgVoteResp from 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-13T21:14:52.461549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became leader at term 2"} {"level":"info","ts":"2026-10-13T21:14:52.461566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4c43c9f84c6588d4 elected leader 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-13T21:14:52.462761Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4c43c9f84c6588d4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.73:2379]}","request-path":"/0/members/4c43c9f84c6588d4/attributes","cluster-id":"49c90045dbd991f3","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T21:14:52.462778Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T21:14:52.463036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T21:14:52.463906Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T21:14:52.464017Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T21:14:52.466751Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.73:2379"} {"level":"info","ts":"2026-10-13T21:14:52.466925Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:14:52.46989Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T21:14:52.478366Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:14:52.478675Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:14:52.478779Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:15:37.473428Z","caller":"traceutil/trace.go:171","msg":"trace[2003143927] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"147.704345ms","start":"2026-10-13T21:15:37.3257Z","end":"2026-10-13T21:15:37.473404Z","steps":["trace[2003143927] 'process raft request' (duration: 67.228756ms)","trace[2003143927] 'compare' (duration: 80.358857ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:15:37.777004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.899786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:15:37.777248Z","caller":"traceutil/trace.go:171","msg":"trace[118899018] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"184.632502ms","start":"2026-10-13T21:15:37.592602Z","end":"2026-10-13T21:15:37.777234Z","steps":["trace[118899018] 'read index received' (duration: 19.16µs)","trace[118899018] 'applied index is now lower than readState.Index' (duration: 184.612502ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:15:37.777392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.777764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:15:37.777339Z","caller":"traceutil/trace.go:171","msg":"trace[1795738862] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"395.853469ms","start":"2026-10-13T21:15:37.381405Z","end":"2026-10-13T21:15:37.777258Z","steps":["trace[1795738862] 'process raft request' (duration: 206.310722ms)","trace[1795738862] 'compare' (duration: 188.739343ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:15:37.777423Z","caller":"traceutil/trace.go:171","msg":"trace[423085539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"184.841565ms","start":"2026-10-13T21:15:37.592572Z","end":"2026-10-13T21:15:37.777414Z","steps":["trace[423085539] 'agreement among raft nodes before linearized reading' (duration: 184.738503ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:15:37.777523Z","caller":"traceutil/trace.go:171","msg":"trace[1415908051] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"395.91592ms","start":"2026-10-13T21:15:37.381594Z","end":"2026-10-13T21:15:37.77751Z","steps":["trace[1415908051] 'process raft request' (duration: 395.517113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:15:37.777597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:15:37.381573Z","time spent":"395.978331ms","remote":"127.0.0.1:55872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T21:15:37.777584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:15:37.381375Z","time spent":"396.069723ms","remote":"127.0.0.1:55872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:15:43.173195Z","caller":"traceutil/trace.go:171","msg":"trace[1869624971] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"287.902275ms","start":"2026-10-13T21:15:42.885241Z","end":"2026-10-13T21:15:43.173144Z","steps":["trace[1869624971] 'process raft request' (duration: 287.718022ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:15:43.178431Z","caller":"traceutil/trace.go:171","msg":"trace[492310133] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:671; }","duration":"204.910199ms","start":"2026-10-13T21:15:42.973504Z","end":"2026-10-13T21:15:43.178415Z","steps":["trace[492310133] 'read index received' (duration: 199.358816ms)","trace[492310133] 'applied index is now lower than readState.Index' (duration: 5.550573ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:15:43.1786Z","caller":"traceutil/trace.go:171","msg":"trace[1445080916] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"261.987866ms","start":"2026-10-13T21:15:42.916576Z","end":"2026-10-13T21:15:43.178564Z","steps":["trace[1445080916] 'process raft request' (duration: 261.66539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:15:43.178823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.279775ms","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-10-13T21:15:43.178872Z","caller":"traceutil/trace.go:171","msg":"trace[326917428] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"205.365507ms","start":"2026-10-13T21:15:42.973493Z","end":"2026-10-13T21:15:43.178858Z","steps":["trace[326917428] 'agreement among raft nodes before linearized reading' (duration: 205.087452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:15:43.178997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.17409ms","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-10-13T21:15:43.179083Z","caller":"traceutil/trace.go:171","msg":"trace[872497431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"200.292771ms","start":"2026-10-13T21:15:42.978769Z","end":"2026-10-13T21:15:43.179062Z","steps":["trace[872497431] 'agreement among raft nodes before linearized reading' (duration: 200.031817ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:15:43.179495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.477849ms","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-10-13T21:15:43.179558Z","caller":"traceutil/trace.go:171","msg":"trace[1425460827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"192.54366ms","start":"2026-10-13T21:15:42.987Z","end":"2026-10-13T21:15:43.179544Z","steps":["trace[1425460827] 'agreement among raft nodes before linearized reading' (duration: 192.221285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:15:43.801601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.949382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:15:43.801888Z","caller":"traceutil/trace.go:171","msg":"trace[1720774834] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"514.30248ms","start":"2026-10-13T21:15:43.287535Z","end":"2026-10-13T21:15:43.801838Z","steps":["trace[1720774834] 'process raft request' (duration: 295.003912ms)","trace[1720774834] 'compare' (duration: 218.748529ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:15:43.802334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:15:43.28751Z","time spent":"514.475723ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:15:43.806052Z","caller":"traceutil/trace.go:171","msg":"trace[1028642047] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"164.314634ms","start":"2026-10-13T21:15:43.641717Z","end":"2026-10-13T21:15:43.806031Z","steps":["trace[1028642047] 'process raft request' (duration: 161.352324ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:15:45.133962Z","caller":"traceutil/trace.go:171","msg":"trace[1998271671] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"109.859164ms","start":"2026-10-13T21:15:45.024043Z","end":"2026-10-13T21:15:45.133902Z","steps":["trace[1998271671] 'process raft request' (duration: 99.074825ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.871859Z","caller":"traceutil/trace.go:171","msg":"trace[690628311] transaction","detail":"{read_only:false; response_revision:1638; number_of_response:1; }","duration":"134.30252ms","start":"2026-10-13T21:17:04.737533Z","end":"2026-10-13T21:17:04.871836Z","steps":["trace[690628311] 'process raft request' (duration: 134.253069ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.871888Z","caller":"traceutil/trace.go:171","msg":"trace[1216311494] transaction","detail":"{read_only:false; response_revision:1637; number_of_response:1; }","duration":"141.856369ms","start":"2026-10-13T21:17:04.730001Z","end":"2026-10-13T21:17:04.871858Z","steps":["trace[1216311494] 'process raft request' (duration: 136.328523ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.996199Z","caller":"traceutil/trace.go:171","msg":"trace[1967111168] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"106.847675ms","start":"2026-10-13T21:17:04.889327Z","end":"2026-10-13T21:17:04.996174Z","steps":["trace[1967111168] 'process raft request' (duration: 102.327001ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.996575Z","caller":"traceutil/trace.go:171","msg":"trace[2062822412] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1646; }","duration":"104.275594ms","start":"2026-10-13T21:17:04.892267Z","end":"2026-10-13T21:17:04.996543Z","steps":["trace[2062822412] 'process raft request' (duration: 103.874879ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.996793Z","caller":"traceutil/trace.go:171","msg":"trace[183055468] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"104.290784ms","start":"2026-10-13T21:17:04.892483Z","end":"2026-10-13T21:17:04.996774Z","steps":["trace[183055468] 'process raft request' (duration: 103.95219ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.997112Z","caller":"traceutil/trace.go:171","msg":"trace[1315930948] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"104.103451ms","start":"2026-10-13T21:17:04.892984Z","end":"2026-10-13T21:17:04.997088Z","steps":["trace[1315930948] 'process raft request' (duration: 103.691367ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:04.997127Z","caller":"traceutil/trace.go:171","msg":"trace[797475798] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"101.275319ms","start":"2026-10-13T21:17:04.895831Z","end":"2026-10-13T21:17:04.997106Z","steps":["trace[797475798] 'process raft request' (duration: 101.187688ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:05.018245Z","caller":"traceutil/trace.go:171","msg":"trace[614227699] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"111.060654ms","start":"2026-10-13T21:17:04.907158Z","end":"2026-10-13T21:17:05.018219Z","steps":["trace[614227699] 'process raft request' (duration: 110.873402ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:05.018574Z","caller":"traceutil/trace.go:171","msg":"trace[607679117] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"110.461947ms","start":"2026-10-13T21:17:04.908098Z","end":"2026-10-13T21:17:05.01856Z","steps":["trace[607679117] 'process raft request' (duration: 110.058543ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:05.018665Z","caller":"traceutil/trace.go:171","msg":"trace[145905337] linearizableReadLoop","detail":"{readStateIndex:1719; appliedIndex:1710; }","duration":"108.139949ms","start":"2026-10-13T21:17:04.910488Z","end":"2026-10-13T21:17:05.018627Z","steps":["trace[145905337] 'read index received' (duration: 81.254231ms)","trace[145905337] 'applied index is now lower than readState.Index' (duration: 26.884428ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:17:05.01893Z","caller":"traceutil/trace.go:171","msg":"trace[1678923871] transaction","detail":"{read_only:false; response_revision:1652; number_of_response:1; }","duration":"110.529658ms","start":"2026-10-13T21:17:04.908389Z","end":"2026-10-13T21:17:05.018918Z","steps":["trace[1678923871] 'process raft request' (duration: 110.036412ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:05.019182Z","caller":"traceutil/trace.go:171","msg":"trace[1750832103] transaction","detail":"{read_only:false; response_revision:1653; number_of_response:1; }","duration":"109.148052ms","start":"2026-10-13T21:17:04.910024Z","end":"2026-10-13T21:17:05.019172Z","steps":["trace[1750832103] 'process raft request' (duration: 108.493724ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:05.019406Z","caller":"traceutil/trace.go:171","msg":"trace[1892113357] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"102.967988ms","start":"2026-10-13T21:17:04.916426Z","end":"2026-10-13T21:17:05.019394Z","steps":["trace[1892113357] 'process raft request' (duration: 102.137868ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:05.019618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.118832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:1 size:5472"} {"level":"info","ts":"2026-10-13T21:17:05.019659Z","caller":"traceutil/trace.go:171","msg":"trace[1559147267] range","detail":"{range_begin:/registry/deployments/openstack/rabbitmq-cluster-operator; range_end:; response_count:1; response_revision:1654; }","duration":"109.231992ms","start":"2026-10-13T21:17:04.910419Z","end":"2026-10-13T21:17:05.019651Z","steps":["trace[1559147267] 'agreement among raft nodes before linearized reading' (duration: 109.097331ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:21.947717Z","caller":"traceutil/trace.go:171","msg":"trace[1897655463] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"202.106201ms","start":"2026-10-13T21:17:21.745591Z","end":"2026-10-13T21:17:21.947697Z","steps":["trace[1897655463] 'process raft request' (duration: 201.947159ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:22.212632Z","caller":"traceutil/trace.go:171","msg":"trace[1192271421] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1978; }","duration":"357.952599ms","start":"2026-10-13T21:17:21.85465Z","end":"2026-10-13T21:17:22.212603Z","steps":["trace[1192271421] 'read index received' (duration: 92.908957ms)","trace[1192271421] 'applied index is now lower than readState.Index' (duration: 265.041952ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:17:22.212864Z","caller":"traceutil/trace.go:171","msg":"trace[1157541515] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"467.214103ms","start":"2026-10-13T21:17:21.745628Z","end":"2026-10-13T21:17:22.212842Z","steps":["trace[1157541515] 'process raft request' (duration: 396.442729ms)","trace[1157541515] 'compare' (duration: 70.402549ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:17:22.212977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.301913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-13T21:17:22.213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:17:21.745608Z","time spent":"467.309203ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:17:22.213076Z","caller":"traceutil/trace.go:171","msg":"trace[385060933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1905; }","duration":"358.436985ms","start":"2026-10-13T21:17:21.85461Z","end":"2026-10-13T21:17:22.213047Z","steps":["trace[385060933] 'agreement among raft nodes before linearized reading' (duration: 358.191312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:22.213101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.595128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T21:17:22.213127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:17:21.854591Z","time spent":"358.528816ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-13T21:17:22.213135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.405184ms","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-10-13T21:17:22.213263Z","caller":"traceutil/trace.go:171","msg":"trace[729471274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1905; }","duration":"358.630277ms","start":"2026-10-13T21:17:21.85461Z","end":"2026-10-13T21:17:22.21324Z","steps":["trace[729471274] 'agreement among raft nodes before linearized reading' (duration: 358.329194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:22.213329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:17:21.854591Z","time spent":"358.723918ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-13T21:17:22.213156Z","caller":"traceutil/trace.go:171","msg":"trace[1743787546] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1905; }","duration":"294.683459ms","start":"2026-10-13T21:17:21.918459Z","end":"2026-10-13T21:17:22.213142Z","steps":["trace[1743787546] 'agreement among raft nodes before linearized reading' (duration: 294.585268ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:22.597081Z","caller":"traceutil/trace.go:171","msg":"trace[1553365677] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"225.956536ms","start":"2026-10-13T21:17:22.371097Z","end":"2026-10-13T21:17:22.597053Z","steps":["trace[1553365677] 'process raft request' (duration: 225.799205ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:22.609132Z","caller":"traceutil/trace.go:171","msg":"trace[1457309654] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1982; }","duration":"179.326616ms","start":"2026-10-13T21:17:22.429782Z","end":"2026-10-13T21:17:22.609109Z","steps":["trace[1457309654] 'read index received' (duration: 167.163608ms)","trace[1457309654] 'applied index is now lower than readState.Index' (duration: 12.161978ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:17:22.609346Z","caller":"traceutil/trace.go:171","msg":"trace[1655840814] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"237.776671ms","start":"2026-10-13T21:17:22.371551Z","end":"2026-10-13T21:17:22.609328Z","steps":["trace[1655840814] 'process raft request' (duration: 237.425777ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:22.609503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.430259ms","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-10-13T21:17:22.60957Z","caller":"traceutil/trace.go:171","msg":"trace[1536449322] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1909; }","duration":"143.52023ms","start":"2026-10-13T21:17:22.46603Z","end":"2026-10-13T21:17:22.60955Z","steps":["trace[1536449322] 'agreement among raft nodes before linearized reading' (duration: 143.317218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:22.60961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.787592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f00eaf7d-6fa9-4e53-a42a-9ea353b45ff7\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-10-13T21:17:22.60971Z","caller":"traceutil/trace.go:171","msg":"trace[1903702602] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f00eaf7d-6fa9-4e53-a42a-9ea353b45ff7; range_end:; response_count:1; response_revision:1909; }","duration":"179.943204ms","start":"2026-10-13T21:17:22.429739Z","end":"2026-10-13T21:17:22.609682Z","steps":["trace[1903702602] 'agreement among raft nodes before linearized reading' (duration: 179.718651ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:23.532028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.933663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f00eaf7d-6fa9-4e53-a42a-9ea353b45ff7\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-10-13T21:17:23.532105Z","caller":"traceutil/trace.go:171","msg":"trace[827167810] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f00eaf7d-6fa9-4e53-a42a-9ea353b45ff7; range_end:; response_count:1; response_revision:1912; }","duration":"160.056415ms","start":"2026-10-13T21:17:23.372029Z","end":"2026-10-13T21:17:23.532085Z","steps":["trace[827167810] 'range keys from in-memory index tree' (duration: 159.769571ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:29.080217Z","caller":"traceutil/trace.go:171","msg":"trace[51038180] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"115.701888ms","start":"2026-10-13T21:17:28.964501Z","end":"2026-10-13T21:17:29.080203Z","steps":["trace[51038180] 'process raft request' (duration: 115.615447ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:30.361896Z","caller":"traceutil/trace.go:171","msg":"trace[491395871] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"107.24533ms","start":"2026-10-13T21:17:30.254602Z","end":"2026-10-13T21:17:30.361847Z","steps":["trace[491395871] 'process raft request' (duration: 106.760294ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:35.020754Z","caller":"traceutil/trace.go:171","msg":"trace[2014961359] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"162.289042ms","start":"2026-10-13T21:17:34.858449Z","end":"2026-10-13T21:17:35.020738Z","steps":["trace[2014961359] 'process raft request' (duration: 162.201071ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:17:56.71498Z","caller":"traceutil/trace.go:171","msg":"trace[697372794] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"117.998397ms","start":"2026-10-13T21:17:56.596958Z","end":"2026-10-13T21:17:56.714956Z","steps":["trace[697372794] 'process raft request' (duration: 110.029315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:58.175156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.523442ms","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-10-13T21:17:58.175254Z","caller":"traceutil/trace.go:171","msg":"trace[350632635] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2147; }","duration":"303.673998ms","start":"2026-10-13T21:17:57.871559Z","end":"2026-10-13T21:17:58.175233Z","steps":["trace[350632635] 'range keys from in-memory index tree' (duration: 303.284484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:17:58.175296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:17:57.871538Z","time spent":"303.74878ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-13T21:17:58.283682Z","caller":"traceutil/trace.go:171","msg":"trace[1964061774] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"104.455831ms","start":"2026-10-13T21:17:58.179197Z","end":"2026-10-13T21:17:58.283653Z","steps":["trace[1964061774] 'process raft request' (duration: 104.211352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:19:16.949321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.106121ms","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-10-13T21:19:16.949408Z","caller":"traceutil/trace.go:171","msg":"trace[813319425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2670; }","duration":"219.253083ms","start":"2026-10-13T21:19:16.730136Z","end":"2026-10-13T21:19:16.949389Z","steps":["trace[813319425] 'count revisions from in-memory index tree' (duration: 219.016548ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:06.369598Z","caller":"traceutil/trace.go:171","msg":"trace[818396061] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"102.340318ms","start":"2026-10-13T21:24:06.267227Z","end":"2026-10-13T21:24:06.369568Z","steps":["trace[818396061] 'process raft request' (duration: 98.607205ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:14.854425Z","caller":"traceutil/trace.go:171","msg":"trace[586729479] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"102.026006ms","start":"2026-10-13T21:24:14.75237Z","end":"2026-10-13T21:24:14.854396Z","steps":["trace[586729479] 'process raft request' (duration: 101.864334ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.272255Z","caller":"traceutil/trace.go:171","msg":"trace[783192650] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"210.177821ms","start":"2026-10-13T21:24:18.062054Z","end":"2026-10-13T21:24:18.272232Z","steps":["trace[783192650] 'process raft request' (duration: 210.141911ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.272331Z","caller":"traceutil/trace.go:171","msg":"trace[295789505] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"210.253983ms","start":"2026-10-13T21:24:18.062054Z","end":"2026-10-13T21:24:18.272308Z","steps":["trace[295789505] 'process raft request' (duration: 210.016409ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.272615Z","caller":"traceutil/trace.go:171","msg":"trace[364189310] linearizableReadLoop","detail":"{readStateIndex:5213; appliedIndex:5213; }","duration":"210.514736ms","start":"2026-10-13T21:24:18.062074Z","end":"2026-10-13T21:24:18.272589Z","steps":["trace[364189310] 'read index received' (duration: 210.497686ms)","trace[364189310] 'applied index is now lower than readState.Index' (duration: 14.8µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:24:18.272897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.79939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-10-13T21:24:18.272981Z","caller":"traceutil/trace.go:171","msg":"trace[1855710579] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5020; }","duration":"210.923832ms","start":"2026-10-13T21:24:18.062036Z","end":"2026-10-13T21:24:18.27296Z","steps":["trace[1855710579] 'agreement among raft nodes before linearized reading' (duration: 210.643008ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.512584Z","caller":"traceutil/trace.go:171","msg":"trace[449987308] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"450.367594ms","start":"2026-10-13T21:24:18.062192Z","end":"2026-10-13T21:24:18.51256Z","steps":["trace[449987308] 'process raft request' (duration: 427.99837ms)","trace[449987308] 'compare' (duration: 22.132901ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:18.512654Z","caller":"traceutil/trace.go:171","msg":"trace[1686183999] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"450.409275ms","start":"2026-10-13T21:24:18.062205Z","end":"2026-10-13T21:24:18.512614Z","steps":["trace[1686183999] 'process raft request' (duration: 450.244643ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.512693Z","caller":"traceutil/trace.go:171","msg":"trace[2078273505] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"171.421737ms","start":"2026-10-13T21:24:18.34125Z","end":"2026-10-13T21:24:18.512672Z","steps":["trace[2078273505] 'process raft request' (duration: 171.381126ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.51283Z","caller":"traceutil/trace.go:171","msg":"trace[725875754] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"450.607808ms","start":"2026-10-13T21:24:18.062215Z","end":"2026-10-13T21:24:18.512822Z","steps":["trace[725875754] 'process raft request' (duration: 450.278523ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.51287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.062198Z","time spent":"450.653708ms","remote":"127.0.0.1:55902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":919,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T21:24:18.512978Z","caller":"traceutil/trace.go:171","msg":"trace[1526093244] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"450.658178ms","start":"2026-10-13T21:24:18.062314Z","end":"2026-10-13T21:24:18.512972Z","steps":["trace[1526093244] 'process raft request' (duration: 450.214052ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.51301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.062306Z","time spent":"450.690668ms","remote":"127.0.0.1:55902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":943,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T21:24:18.513091Z","caller":"traceutil/trace.go:171","msg":"trace[2070239822] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5213; }","duration":"240.418866ms","start":"2026-10-13T21:24:18.272665Z","end":"2026-10-13T21:24:18.513084Z","steps":["trace[2070239822] 'read index received' (duration: 217.537254ms)","trace[2070239822] 'applied index is now lower than readState.Index' (duration: 22.880872ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:18.513168Z","caller":"traceutil/trace.go:171","msg":"trace[1003431583] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"441.361128ms","start":"2026-10-13T21:24:18.071799Z","end":"2026-10-13T21:24:18.51316Z","steps":["trace[1003431583] 'process raft request' (duration: 440.773219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.51321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.071779Z","time spent":"441.402508ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3952,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T21:24:18.513462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.720664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-10-13T21:24:18.51354Z","caller":"traceutil/trace.go:171","msg":"trace[1467728984] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5026; }","duration":"236.816836ms","start":"2026-10-13T21:24:18.276699Z","end":"2026-10-13T21:24:18.513516Z","steps":["trace[1467728984] 'agreement among raft nodes before linearized reading' (duration: 236.642203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.51358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.06219Z","time spent":"450.549807ms","remote":"127.0.0.1:55902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T21:24:18.513789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.660925ms","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":"warn","ts":"2026-10-13T21:24:18.513793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.040519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-015dde3d-6624-4d64-8b07-69b1fbad9aa0\" ","response":"range_response_count:1 size:3645"} {"level":"warn","ts":"2026-10-13T21:24:18.512698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.062186Z","time spent":"450.451215ms","remote":"127.0.0.1:55902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":943,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T21:24:18.513891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.386061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-10-13T21:24:18.513919Z","caller":"traceutil/trace.go:171","msg":"trace[264816953] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5026; }","duration":"318.443761ms","start":"2026-10-13T21:24:18.195468Z","end":"2026-10-13T21:24:18.513912Z","steps":["trace[264816953] 'agreement among raft nodes before linearized reading' (duration: 317.825303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.513944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:18.195451Z","time spent":"318.486893ms","remote":"127.0.0.1:55914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207433,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-10-13T21:24:18.513972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.928846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-8lhbb\" ","response":"range_response_count:1 size:9348"} {"level":"info","ts":"2026-10-13T21:24:18.513971Z","caller":"traceutil/trace.go:171","msg":"trace[1839540944] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-015dde3d-6624-4d64-8b07-69b1fbad9aa0; range_end:; response_count:1; response_revision:5026; }","duration":"195.193901ms","start":"2026-10-13T21:24:18.318662Z","end":"2026-10-13T21:24:18.513856Z","steps":["trace[1839540944] 'agreement among raft nodes before linearized reading' (duration: 194.770335ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.51403Z","caller":"traceutil/trace.go:171","msg":"trace[408794326] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-8lhbb; range_end:; response_count:1; response_revision:5026; }","duration":"175.016988ms","start":"2026-10-13T21:24:18.338999Z","end":"2026-10-13T21:24:18.514016Z","steps":["trace[408794326] 'agreement among raft nodes before linearized reading' (duration: 174.879586ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.513853Z","caller":"traceutil/trace.go:171","msg":"trace[1005590590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5026; }","duration":"207.751347ms","start":"2026-10-13T21:24:18.306088Z","end":"2026-10-13T21:24:18.513839Z","steps":["trace[1005590590] 'agreement among raft nodes before linearized reading' (duration: 207.591545ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:18.971817Z","caller":"traceutil/trace.go:171","msg":"trace[892335354] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"228.698871ms","start":"2026-10-13T21:24:18.743091Z","end":"2026-10-13T21:24:18.97179Z","steps":["trace[892335354] 'process raft request' (duration: 200.755049ms)","trace[892335354] 'compare' (duration: 27.677678ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:18.972165Z","caller":"traceutil/trace.go:171","msg":"trace[1456260141] linearizableReadLoop","detail":"{readStateIndex:5233; appliedIndex:5232; }","duration":"228.399227ms","start":"2026-10-13T21:24:18.743744Z","end":"2026-10-13T21:24:18.972144Z","steps":["trace[1456260141] 'read index received' (duration: 200.157071ms)","trace[1456260141] 'applied index is now lower than readState.Index' (duration: 28.238496ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:24:18.972404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.595362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-13T21:24:18.972432Z","caller":"traceutil/trace.go:171","msg":"trace[1861174521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5040; }","duration":"105.670774ms","start":"2026-10-13T21:24:18.866755Z","end":"2026-10-13T21:24:18.972426Z","steps":["trace[1861174521] 'agreement among raft nodes before linearized reading' (duration: 105.578473ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.972449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.19482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-10-13T21:24:18.972528Z","caller":"traceutil/trace.go:171","msg":"trace[1470219292] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:5040; }","duration":"227.293371ms","start":"2026-10-13T21:24:18.745216Z","end":"2026-10-13T21:24:18.972509Z","steps":["trace[1470219292] 'agreement among raft nodes before linearized reading' (duration: 227.082888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.97258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.067957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T21:24:18.973525Z","caller":"traceutil/trace.go:171","msg":"trace[1866426848] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:5040; }","duration":"146.04919ms","start":"2026-10-13T21:24:18.827467Z","end":"2026-10-13T21:24:18.973517Z","steps":["trace[1866426848] 'agreement among raft nodes before linearized reading' (duration: 145.088257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:18.973763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.01319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:24:18.973787Z","caller":"traceutil/trace.go:171","msg":"trace[1567812247] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5040; }","duration":"230.04641ms","start":"2026-10-13T21:24:18.743734Z","end":"2026-10-13T21:24:18.97378Z","steps":["trace[1567812247] 'agreement among raft nodes before linearized reading' (duration: 228.516389ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:19.204106Z","caller":"traceutil/trace.go:171","msg":"trace[490517467] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"117.717212ms","start":"2026-10-13T21:24:19.086366Z","end":"2026-10-13T21:24:19.204083Z","steps":["trace[490517467] 'process raft request' (duration: 117.474729ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:19.204628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.023706ms","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-10-13T21:24:19.204739Z","caller":"traceutil/trace.go:171","msg":"trace[1093551095] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5047; }","duration":"108.179459ms","start":"2026-10-13T21:24:19.096551Z","end":"2026-10-13T21:24:19.20473Z","steps":["trace[1093551095] 'agreement among raft nodes before linearized reading' (duration: 108.028206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:19.204997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.58824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60875"} {"level":"info","ts":"2026-10-13T21:24:19.205051Z","caller":"traceutil/trace.go:171","msg":"trace[1058575692] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5047; }","duration":"127.710372ms","start":"2026-10-13T21:24:19.077334Z","end":"2026-10-13T21:24:19.205045Z","steps":["trace[1058575692] 'agreement among raft nodes before linearized reading' (duration: 127.57318ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:32.064074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.308361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:24:32.064221Z","caller":"traceutil/trace.go:171","msg":"trace[2133920407] linearizableReadLoop","detail":"{readStateIndex:5424; appliedIndex:5423; }","duration":"463.68213ms","start":"2026-10-13T21:24:31.600519Z","end":"2026-10-13T21:24:32.064201Z","steps":["trace[2133920407] 'read index received' (duration: 1.101455ms)","trace[2133920407] 'applied index is now lower than readState.Index' (duration: 462.578965ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:32.064244Z","caller":"traceutil/trace.go:171","msg":"trace[1799739436] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"489.066764ms","start":"2026-10-13T21:24:31.575146Z","end":"2026-10-13T21:24:32.064212Z","steps":["trace[1799739436] 'process raft request' (duration: 26.506ms)","trace[1799739436] 'compare' (duration: 462.078748ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:24:32.064397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.874373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T21:24:32.06441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:31.575127Z","time spent":"489.202056ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:24:32.06444Z","caller":"traceutil/trace.go:171","msg":"trace[21836257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5223; }","duration":"463.965984ms","start":"2026-10-13T21:24:31.600462Z","end":"2026-10-13T21:24:32.064428Z","steps":["trace[21836257] 'agreement among raft nodes before linearized reading' (duration: 463.885683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:32.064477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:31.600437Z","time spent":"464.031195ms","remote":"127.0.0.1:55820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T21:24:32.064636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.306063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:24:32.064702Z","caller":"traceutil/trace.go:171","msg":"trace[1072748119] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5223; }","duration":"409.396794ms","start":"2026-10-13T21:24:31.655286Z","end":"2026-10-13T21:24:32.064683Z","steps":["trace[1072748119] 'agreement among raft nodes before linearized reading' (duration: 409.263662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:32.064744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:31.655264Z","time spent":"409.470175ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"warn","ts":"2026-10-13T21:24:32.064845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.000104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:24:32.064898Z","caller":"traceutil/trace.go:171","msg":"trace[532526169] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5223; }","duration":"263.058735ms","start":"2026-10-13T21:24:31.801825Z","end":"2026-10-13T21:24:32.064884Z","steps":["trace[532526169] 'agreement among raft nodes before linearized reading' (duration: 262.976624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:32.615313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.645616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:24:32.615412Z","caller":"traceutil/trace.go:171","msg":"trace[1524266748] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5425; }","duration":"219.252693ms","start":"2026-10-13T21:24:32.396142Z","end":"2026-10-13T21:24:32.615395Z","steps":["trace[1524266748] 'read index received' (duration: 38.373915ms)","trace[1524266748] 'applied index is now lower than readState.Index' (duration: 180.877538ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:32.615711Z","caller":"traceutil/trace.go:171","msg":"trace[1566993417] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"228.065686ms","start":"2026-10-13T21:24:32.387608Z","end":"2026-10-13T21:24:32.615674Z","steps":["trace[1566993417] 'process raft request' (duration: 46.969674ms)","trace[1566993417] 'compare' (duration: 180.489574ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:24:32.61591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.71604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"warn","ts":"2026-10-13T21:24:32.615791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.483295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T21:24:32.616003Z","caller":"traceutil/trace.go:171","msg":"trace[1209700642] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5225; }","duration":"137.733438ms","start":"2026-10-13T21:24:32.478252Z","end":"2026-10-13T21:24:32.615985Z","steps":["trace[1209700642] 'agreement among raft nodes before linearized reading' (duration: 137.472774ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:32.616047Z","caller":"traceutil/trace.go:171","msg":"trace[1330605249] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5225; }","duration":"219.844552ms","start":"2026-10-13T21:24:32.396118Z","end":"2026-10-13T21:24:32.615963Z","steps":["trace[1330605249] 'agreement among raft nodes before linearized reading' (duration: 219.559418ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:32.805928Z","caller":"traceutil/trace.go:171","msg":"trace[1366112301] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"181.504927ms","start":"2026-10-13T21:24:32.624394Z","end":"2026-10-13T21:24:32.805899Z","steps":["trace[1366112301] 'process raft request' (duration: 120.078232ms)","trace[1366112301] 'compare' (duration: 61.272243ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:32.805975Z","caller":"traceutil/trace.go:171","msg":"trace[174608341] linearizableReadLoop","detail":"{readStateIndex:5427; appliedIndex:5426; }","duration":"151.454659ms","start":"2026-10-13T21:24:32.654495Z","end":"2026-10-13T21:24:32.80595Z","steps":["trace[174608341] 'read index received' (duration: 89.918402ms)","trace[174608341] 'applied index is now lower than readState.Index' (duration: 61.535157ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:24:32.806421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.909485ms","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-10-13T21:24:32.806476Z","caller":"traceutil/trace.go:171","msg":"trace[1704749694] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"142.679037ms","start":"2026-10-13T21:24:32.663783Z","end":"2026-10-13T21:24:32.806462Z","steps":["trace[1704749694] 'process raft request' (duration: 142.106769ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:32.806498Z","caller":"traceutil/trace.go:171","msg":"trace[164171302] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5227; }","duration":"152.052327ms","start":"2026-10-13T21:24:32.654425Z","end":"2026-10-13T21:24:32.806477Z","steps":["trace[164171302] 'agreement among raft nodes before linearized reading' (duration: 151.604321ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:33.077128Z","caller":"traceutil/trace.go:171","msg":"trace[836541326] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"266.361438ms","start":"2026-10-13T21:24:32.810729Z","end":"2026-10-13T21:24:33.077091Z","steps":["trace[836541326] 'process raft request' (duration: 248.374658ms)","trace[836541326] 'compare' (duration: 17.671276ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:33.172237Z","caller":"traceutil/trace.go:171","msg":"trace[471192722] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"361.067677ms","start":"2026-10-13T21:24:32.811143Z","end":"2026-10-13T21:24:33.172211Z","steps":["trace[471192722] 'process raft request' (duration: 360.815994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.172398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:32.811121Z","time spent":"361.188079ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:24:33.172985Z","caller":"traceutil/trace.go:171","msg":"trace[650040576] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"360.450358ms","start":"2026-10-13T21:24:32.812517Z","end":"2026-10-13T21:24:33.172967Z","steps":["trace[650040576] 'process raft request' (duration: 359.589836ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.173126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:32.812504Z","time spent":"360.57008ms","remote":"127.0.0.1:56074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T21:24:33.173208Z","caller":"traceutil/trace.go:171","msg":"trace[254810588] linearizableReadLoop","detail":"{readStateIndex:5431; appliedIndex:5428; }","duration":"312.861766ms","start":"2026-10-13T21:24:32.860327Z","end":"2026-10-13T21:24:33.173189Z","steps":["trace[254810588] 'read index received' (duration: 198.874359ms)","trace[254810588] 'applied index is now lower than readState.Index' (duration: 113.985837ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:33.173308Z","caller":"traceutil/trace.go:171","msg":"trace[1908271464] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"156.335236ms","start":"2026-10-13T21:24:33.016959Z","end":"2026-10-13T21:24:33.173295Z","steps":["trace[1908271464] 'process raft request' (duration: 155.927451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.173412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.163717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T21:24:33.17347Z","caller":"traceutil/trace.go:171","msg":"trace[1811899015] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5231; }","duration":"172.261948ms","start":"2026-10-13T21:24:33.001193Z","end":"2026-10-13T21:24:33.173455Z","steps":["trace[1811899015] 'agreement among raft nodes before linearized reading' (duration: 172.145206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.173641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.296852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:24:33.173714Z","caller":"traceutil/trace.go:171","msg":"trace[1985271562] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5231; }","duration":"313.416343ms","start":"2026-10-13T21:24:32.860281Z","end":"2026-10-13T21:24:33.173697Z","steps":["trace[1985271562] 'agreement among raft nodes before linearized reading' (duration: 313.311311ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.173748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:24:32.86026Z","time spent":"313.478365ms","remote":"127.0.0.1:46704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-10-13T21:24:33.173767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.205747ms","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-10-13T21:24:33.173816Z","caller":"traceutil/trace.go:171","msg":"trace[68757864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5231; }","duration":"126.289637ms","start":"2026-10-13T21:24:33.047512Z","end":"2026-10-13T21:24:33.173802Z","steps":["trace[68757864] 'agreement among raft nodes before linearized reading' (duration: 126.144765ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:24:33.297365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.28271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:24:33.297552Z","caller":"traceutil/trace.go:171","msg":"trace[1796396890] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"119.342781ms","start":"2026-10-13T21:24:33.17819Z","end":"2026-10-13T21:24:33.297533Z","steps":["trace[1796396890] 'process raft request' (duration: 17.813648ms)","trace[1796396890] 'compare' (duration: 101.078517ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:24:33.297708Z","caller":"traceutil/trace.go:171","msg":"trace[1898867236] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"118.756673ms","start":"2026-10-13T21:24:33.178928Z","end":"2026-10-13T21:24:33.297685Z","steps":["trace[1898867236] 'process raft request' (duration: 118.52587ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:33.654281Z","caller":"traceutil/trace.go:171","msg":"trace[818504181] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"162.966078ms","start":"2026-10-13T21:24:33.491277Z","end":"2026-10-13T21:24:33.654243Z","steps":["trace[818504181] 'process raft request' (duration: 162.745075ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:24:52.80449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-10-13T21:24:52.8835Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"77.461258ms","hash":153116869,"current-db-size-bytes":50544640,"current-db-size":"50 MB","current-db-size-in-use-bytes":27287552,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-13T21:24:52.883567Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":153116869,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-10-13T21:25:51.714997Z","caller":"traceutil/trace.go:171","msg":"trace[1722590403] transaction","detail":"{read_only:false; response_revision:5865; number_of_response:1; }","duration":"132.665617ms","start":"2026-10-13T21:25:51.582307Z","end":"2026-10-13T21:25:51.714972Z","steps":["trace[1722590403] 'process raft request' (duration: 132.296682ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:25:51.715492Z","caller":"traceutil/trace.go:171","msg":"trace[611898606] linearizableReadLoop","detail":"{readStateIndex:6085; appliedIndex:6083; }","duration":"132.032047ms","start":"2026-10-13T21:25:51.583447Z","end":"2026-10-13T21:25:51.715479Z","steps":["trace[611898606] 'read index received' (duration: 92.811749ms)","trace[611898606] 'applied index is now lower than readState.Index' (duration: 39.218868ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:25:51.71576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.289881ms","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-10-13T21:25:51.715802Z","caller":"traceutil/trace.go:171","msg":"trace[814047353] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5865; }","duration":"132.387032ms","start":"2026-10-13T21:25:51.583403Z","end":"2026-10-13T21:25:51.715791Z","steps":["trace[814047353] 'agreement among raft nodes before linearized reading' (duration: 132.20132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:25:51.71601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.727149ms","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-10-13T21:25:51.716094Z","caller":"traceutil/trace.go:171","msg":"trace[52715347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5865; }","duration":"124.85644ms","start":"2026-10-13T21:25:51.591225Z","end":"2026-10-13T21:25:51.716081Z","steps":["trace[52715347] 'agreement among raft nodes before linearized reading' (duration: 124.644297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:25:51.716489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.81919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:25:51.71655Z","caller":"traceutil/trace.go:171","msg":"trace[1798592540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5865; }","duration":"124.927941ms","start":"2026-10-13T21:25:51.591607Z","end":"2026-10-13T21:25:51.716535Z","steps":["trace[1798592540] 'agreement among raft nodes before linearized reading' (duration: 124.81089ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:29:52.813318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5358} {"level":"info","ts":"2026-10-13T21:29:52.926282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5358,"took":"111.408679ms","hash":2279689407,"current-db-size-bytes":50544640,"current-db-size":"50 MB","current-db-size-in-use-bytes":18649088,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-13T21:29:52.926347Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2279689407,"revision":5358,"compact-revision":2868}