{"level":"warn","ts":"2026-10-17T10:04:40.362988Z","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-17T10:04:40.363109Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.96: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.96:2380","--initial-cluster=instance=https://162.253.55.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.96: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-17T10:04:40.363212Z","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-17T10:04:40.363233Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-17T10:04:40.363265Z","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-17T10:04:40.364253Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"]} {"level":"info","ts":"2026-10-17T10:04:40.364378Z","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.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.96: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-17T10:04:40.367846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.086436ms"} {"level":"info","ts":"2026-10-17T10:04:40.3741Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"64a80de7883e6886","cluster-id":"8160e60c0578d165"} {"level":"info","ts":"2026-10-17T10:04:40.374206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:04:40.374238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:04:40.374255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 64a80de7883e6886 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:04:40.374271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:04:40.374325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"warn","ts":"2026-10-17T10:04:40.380052Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:04:40.384037Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:04:40.385785Z","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-17T10:04:40.390072Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"64a80de7883e6886","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:04:40.390393Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"64a80de7883e6886","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:04:40.390366Z","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-17T10:04:40.390555Z","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-17T10:04:40.390579Z","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-17T10:04:40.391143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"info","ts":"2026-10-17T10:04:40.391271Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","added-peer-id":"64a80de7883e6886","added-peer-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-17T10:04:40.394619Z","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-17T10:04:40.394768Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-17T10:04:40.394786Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-17T10:04:40.395007Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"64a80de7883e6886","initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:04:40.395062Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:04:41.075382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:04:41.075441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:04:41.075482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgPreVoteResp from 64a80de7883e6886 at term 1"} {"level":"info","ts":"2026-10-17T10:04:41.07552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:04:41.075536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgVoteResp from 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-17T10:04:41.075551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:04:41.075584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 64a80de7883e6886 elected leader 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-17T10:04:41.076574Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:41.077637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:04:41.077624Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"64a80de7883e6886","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.96:2379]}","request-path":"/0/members/64a80de7883e6886/attributes","cluster-id":"8160e60c0578d165","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:04:41.077709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:04:41.077975Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:04:41.078072Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:04:41.078273Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:41.078423Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:41.078466Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:41.080995Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.96:2379"} {"level":"info","ts":"2026-10-17T10:04:41.083134Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:05:30.502539Z","caller":"traceutil/trace.go:171","msg":"trace[1883222788] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"104.030703ms","start":"2026-10-17T10:05:30.398474Z","end":"2026-10-17T10:05:30.502504Z","steps":["trace[1883222788] 'process raft request' (duration: 56.65132ms)","trace[1883222788] 'compare' (duration: 47.20329ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:05:31.061912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.377371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-82mmh\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-17T10:05:31.062019Z","caller":"traceutil/trace.go:171","msg":"trace[656702054] range","detail":"{range_begin:/registry/pods/kube-system/cilium-82mmh; range_end:; response_count:1; response_revision:603; }","duration":"389.583436ms","start":"2026-10-17T10:05:30.672415Z","end":"2026-10-17T10:05:31.061999Z","steps":["trace[656702054] 'range keys from in-memory index tree' (duration: 389.151427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:05:31.06206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:05:30.672392Z","time spent":"389.659168ms","remote":"127.0.0.1:41290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-82mmh\" "} {"level":"info","ts":"2026-10-17T10:05:31.078186Z","caller":"traceutil/trace.go:171","msg":"trace[578169139] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"114.65327ms","start":"2026-10-17T10:05:30.963496Z","end":"2026-10-17T10:05:31.078149Z","steps":["trace[578169139] 'process raft request' (duration: 113.065586ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:31.549042Z","caller":"traceutil/trace.go:171","msg":"trace[442495961] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"466.809707ms","start":"2026-10-17T10:05:31.082176Z","end":"2026-10-17T10:05:31.548985Z","steps":["trace[442495961] 'process raft request' (duration: 465.395597ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:31.54932Z","caller":"traceutil/trace.go:171","msg":"trace[2065121512] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"399.63261ms","start":"2026-10-17T10:05:31.14966Z","end":"2026-10-17T10:05:31.549292Z","steps":["trace[2065121512] 'process raft request' (duration: 399.528199ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:31.549316Z","caller":"traceutil/trace.go:171","msg":"trace[819494538] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"465.400066ms","start":"2026-10-17T10:05:31.08387Z","end":"2026-10-17T10:05:31.54927Z","steps":["trace[819494538] 'process raft request' (duration: 465.055289ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:05:31.550262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:05:31.083843Z","time spent":"465.579851ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:05:31.55033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:05:31.149639Z","time spent":"399.761324ms","remote":"127.0.0.1:41482","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-10-17T10:05:31.550421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:05:31.082144Z","time spent":"467.045892ms","remote":"127.0.0.1:41290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:06:15.265634Z","caller":"traceutil/trace.go:171","msg":"trace[1550295291] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"105.302071ms","start":"2026-10-17T10:06:15.160305Z","end":"2026-10-17T10:06:15.265607Z","steps":["trace[1550295291] 'process raft request' (duration: 105.168327ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:02.589584Z","caller":"traceutil/trace.go:171","msg":"trace[1953188409] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1921; }","duration":"209.20869ms","start":"2026-10-17T10:07:02.380353Z","end":"2026-10-17T10:07:02.589562Z","steps":["trace[1953188409] 'read index received' (duration: 209.026756ms)","trace[1953188409] 'applied index is now lower than readState.Index' (duration: 181.034µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:02.589781Z","caller":"traceutil/trace.go:171","msg":"trace[473435687] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"217.592618ms","start":"2026-10-17T10:07:02.372157Z","end":"2026-10-17T10:07:02.58975Z","steps":["trace[473435687] 'process raft request' (duration: 217.274572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:02.589925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.545667ms","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-17T10:07:02.589985Z","caller":"traceutil/trace.go:171","msg":"trace[1248797540] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1847; }","duration":"209.652919ms","start":"2026-10-17T10:07:02.380317Z","end":"2026-10-17T10:07:02.58997Z","steps":["trace[1248797540] 'agreement among raft nodes before linearized reading' (duration: 209.427014ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:14.963772Z","caller":"traceutil/trace.go:171","msg":"trace[1382109702] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"130.015894ms","start":"2026-10-17T10:07:14.833729Z","end":"2026-10-17T10:07:14.963745Z","steps":["trace[1382109702] 'process raft request' (duration: 129.871231ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:18.712915Z","caller":"traceutil/trace.go:171","msg":"trace[354620986] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"140.015348ms","start":"2026-10-17T10:07:18.572878Z","end":"2026-10-17T10:07:18.712893Z","steps":["trace[354620986] 'process raft request' (duration: 139.840363ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:57.052782Z","caller":"traceutil/trace.go:171","msg":"trace[301860125] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"138.18278ms","start":"2026-10-17T10:07:56.914549Z","end":"2026-10-17T10:07:57.052732Z","steps":["trace[301860125] 'process raft request' (duration: 137.75318ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:57.835137Z","caller":"traceutil/trace.go:171","msg":"trace[928653845] linearizableReadLoop","detail":"{readStateIndex:2282; appliedIndex:2281; }","duration":"122.858813ms","start":"2026-10-17T10:07:57.712255Z","end":"2026-10-17T10:07:57.835113Z","steps":["trace[928653845] 'read index received' (duration: 122.552916ms)","trace[928653845] 'applied index is now lower than readState.Index' (duration: 304.257µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:57.835212Z","caller":"traceutil/trace.go:171","msg":"trace[1418434602] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"145.528847ms","start":"2026-10-17T10:07:57.689647Z","end":"2026-10-17T10:07:57.835176Z","steps":["trace[1418434602] 'process raft request' (duration: 145.295542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:57.835316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.031966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:07:57.835364Z","caller":"traceutil/trace.go:171","msg":"trace[1037104309] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2195; }","duration":"123.143029ms","start":"2026-10-17T10:07:57.712205Z","end":"2026-10-17T10:07:57.835348Z","steps":["trace[1037104309] 'agreement among raft nodes before linearized reading' (duration: 123.041726ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:57.958039Z","caller":"traceutil/trace.go:171","msg":"trace[1481041213] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"117.814564ms","start":"2026-10-17T10:07:57.840158Z","end":"2026-10-17T10:07:57.957973Z","steps":["trace[1481041213] 'process raft request' (duration: 111.951918ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:34.116211Z","caller":"traceutil/trace.go:171","msg":"trace[813214929] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"134.239346ms","start":"2026-10-17T10:08:33.981944Z","end":"2026-10-17T10:08:34.116183Z","steps":["trace[813214929] 'process raft request' (duration: 134.084952ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:15.358087Z","caller":"traceutil/trace.go:171","msg":"trace[2034412457] transaction","detail":"{read_only:false; response_revision:3962; number_of_response:1; }","duration":"125.548957ms","start":"2026-10-17T10:12:15.232514Z","end":"2026-10-17T10:12:15.358063Z","steps":["trace[2034412457] 'process raft request' (duration: 125.393863ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:15.518659Z","caller":"traceutil/trace.go:171","msg":"trace[336812997] linearizableReadLoop","detail":"{readStateIndex:4118; appliedIndex:4116; }","duration":"282.791226ms","start":"2026-10-17T10:12:15.235842Z","end":"2026-10-17T10:12:15.518634Z","steps":["trace[336812997] 'read index received' (duration: 122.116945ms)","trace[336812997] 'applied index is now lower than readState.Index' (duration: 160.673141ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:12:15.518685Z","caller":"traceutil/trace.go:171","msg":"trace[1068995337] transaction","detail":"{read_only:false; response_revision:3964; number_of_response:1; }","duration":"274.070777ms","start":"2026-10-17T10:12:15.244583Z","end":"2026-10-17T10:12:15.518654Z","steps":["trace[1068995337] 'process raft request' (duration: 273.999027ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:15.518711Z","caller":"traceutil/trace.go:171","msg":"trace[655632847] transaction","detail":"{read_only:false; response_revision:3963; number_of_response:1; }","duration":"285.624946ms","start":"2026-10-17T10:12:15.233027Z","end":"2026-10-17T10:12:15.518652Z","steps":["trace[655632847] 'process raft request' (duration: 253.090978ms)","trace[655632847] 'compare' (duration: 32.336264ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:12:15.518975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.601116ms","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":"warn","ts":"2026-10-17T10:12:15.519045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.178015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62976"} {"level":"info","ts":"2026-10-17T10:12:15.519057Z","caller":"traceutil/trace.go:171","msg":"trace[1462193801] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3964; }","duration":"177.733019ms","start":"2026-10-17T10:12:15.341304Z","end":"2026-10-17T10:12:15.519037Z","steps":["trace[1462193801] 'agreement among raft nodes before linearized reading' (duration: 177.531965ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:15.519088Z","caller":"traceutil/trace.go:171","msg":"trace[2073575695] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:3964; }","duration":"283.266996ms","start":"2026-10-17T10:12:15.235809Z","end":"2026-10-17T10:12:15.519076Z","steps":["trace[2073575695] 'agreement among raft nodes before linearized reading' (duration: 282.99885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:12:15.518996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.344541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:12:15.519146Z","caller":"traceutil/trace.go:171","msg":"trace[1534629694] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:3964; }","duration":"164.555835ms","start":"2026-10-17T10:12:15.354576Z","end":"2026-10-17T10:12:15.519131Z","steps":["trace[1534629694] 'agreement among raft nodes before linearized reading' (duration: 164.34433ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:13:42.755891Z","caller":"traceutil/trace.go:171","msg":"trace[986252368] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"125.182396ms","start":"2026-10-17T10:13:42.63068Z","end":"2026-10-17T10:13:42.755863Z","steps":["trace[986252368] 'read index received' (duration: 124.965611ms)","trace[986252368] 'applied index is now lower than readState.Index' (duration: 215.275µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:13:42.756007Z","caller":"traceutil/trace.go:171","msg":"trace[2055654516] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"128.21807ms","start":"2026-10-17T10:13:42.627745Z","end":"2026-10-17T10:13:42.755963Z","steps":["trace[2055654516] 'process raft request' (duration: 127.894554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:13:42.756268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.554854ms","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-17T10:13:42.756364Z","caller":"traceutil/trace.go:171","msg":"trace[2113278843] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5030; }","duration":"125.687837ms","start":"2026-10-17T10:13:42.630654Z","end":"2026-10-17T10:13:42.756342Z","steps":["trace[2113278843] 'agreement among raft nodes before linearized reading' (duration: 125.39281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:13:42.756405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.151653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-10-17T10:13:42.756461Z","caller":"traceutil/trace.go:171","msg":"trace[112895119] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:5030; }","duration":"102.253244ms","start":"2026-10-17T10:13:42.654195Z","end":"2026-10-17T10:13:42.756449Z","steps":["trace[112895119] 'agreement among raft nodes before linearized reading' (duration: 101.927557ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:13:47.451096Z","caller":"traceutil/trace.go:171","msg":"trace[1895039210] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"101.627091ms","start":"2026-10-17T10:13:47.349437Z","end":"2026-10-17T10:13:47.451064Z","steps":["trace[1895039210] 'process raft request' (duration: 67.808406ms)","trace[1895039210] 'compare' (duration: 33.435206ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:14:03.601174Z","caller":"traceutil/trace.go:171","msg":"trace[1429502420] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"519.401724ms","start":"2026-10-17T10:14:03.081722Z","end":"2026-10-17T10:14:03.601123Z","steps":["trace[1429502420] 'process raft request' (duration: 519.18692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:03.601353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:14:03.081692Z","time spent":"519.568707ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:14:03.69536Z","caller":"traceutil/trace.go:171","msg":"trace[1142100187] transaction","detail":"{read_only:false; response_revision:5452; number_of_response:1; }","duration":"609.421755ms","start":"2026-10-17T10:14:03.085894Z","end":"2026-10-17T10:14:03.695316Z","steps":["trace[1142100187] 'process raft request' (duration: 544.175225ms)","trace[1142100187] 'compare' (duration: 64.230468ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:14:03.695548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:14:03.085877Z","time spent":"609.572489ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:14:03.696084Z","caller":"traceutil/trace.go:171","msg":"trace[65541489] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"352.475742ms","start":"2026-10-17T10:14:03.343547Z","end":"2026-10-17T10:14:03.696023Z","steps":["trace[65541489] 'process raft request' (duration: 351.46098ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:03.696341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:14:03.343518Z","time spent":"352.699417ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:14:41.111711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2957} {"level":"info","ts":"2026-10-17T10:14:41.193223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2957,"took":"79.441904ms","hash":2887005873,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":32362496,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T10:14:41.193306Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2887005873,"revision":2957,"compact-revision":-1} {"level":"info","ts":"2026-10-17T10:19:41.118905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5887} {"level":"info","ts":"2026-10-17T10:19:41.217046Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5887,"took":"96.299042ms","hash":3758587751,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":26370048,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T10:19:41.21712Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3758587751,"revision":5887,"compact-revision":2957} {"level":"info","ts":"2026-10-17T10:20:29.397095Z","caller":"traceutil/trace.go:171","msg":"trace[57138698] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"293.323568ms","start":"2026-10-17T10:20:29.103745Z","end":"2026-10-17T10:20:29.397068Z","steps":["trace[57138698] 'process raft request' (duration: 293.144245ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:20:29.578973Z","caller":"traceutil/trace.go:171","msg":"trace[997264228] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"138.195107ms","start":"2026-10-17T10:20:29.44075Z","end":"2026-10-17T10:20:29.578945Z","steps":["trace[997264228] 'process raft request' (duration: 138.068994ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:20:29.579039Z","caller":"traceutil/trace.go:171","msg":"trace[1394502260] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"396.955886ms","start":"2026-10-17T10:20:29.182049Z","end":"2026-10-17T10:20:29.579004Z","steps":["trace[1394502260] 'process raft request' (duration: 315.458962ms)","trace[1394502260] 'compare' (duration: 81.037364ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:20:29.579527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:20:29.182024Z","time spent":"397.336094ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:20:41.228441Z","caller":"traceutil/trace.go:171","msg":"trace[1202423464] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"103.821542ms","start":"2026-10-17T10:20:41.124586Z","end":"2026-10-17T10:20:41.228407Z","steps":["trace[1202423464] 'process raft request' (duration: 90.289003ms)","trace[1202423464] 'compare' (duration: 13.386376ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:20:42.021778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.46789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:20:42.022206Z","caller":"traceutil/trace.go:171","msg":"trace[1692778430] linearizableReadLoop","detail":"{readStateIndex:8871; appliedIndex:8868; }","duration":"378.94548ms","start":"2026-10-17T10:20:41.643237Z","end":"2026-10-17T10:20:42.022183Z","steps":["trace[1692778430] 'read index received' (duration: 23.475042ms)","trace[1692778430] 'applied index is now lower than readState.Index' (duration: 355.468728ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:20:42.022332Z","caller":"traceutil/trace.go:171","msg":"trace[1462005157] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"389.767862ms","start":"2026-10-17T10:20:41.632527Z","end":"2026-10-17T10:20:42.022295Z","steps":["trace[1462005157] 'process raft request' (duration: 389.528657ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:20:42.022363Z","caller":"traceutil/trace.go:171","msg":"trace[938120230] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"390.12393ms","start":"2026-10-17T10:20:41.632195Z","end":"2026-10-17T10:20:42.022319Z","steps":["trace[938120230] 'process raft request' (duration: 224.515635ms)","trace[938120230] 'compare' (duration: 163.720654ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:20:42.022453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.224107ms","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-17T10:20:42.022495Z","caller":"traceutil/trace.go:171","msg":"trace[1054770869] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8563; }","duration":"379.304739ms","start":"2026-10-17T10:20:41.643179Z","end":"2026-10-17T10:20:42.022483Z","steps":["trace[1054770869] 'agreement among raft nodes before linearized reading' (duration: 379.129014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:42.02252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:20:41.632519Z","time spent":"389.897245ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:20:42.022538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:20:41.643156Z","time spent":"379.36785ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T10:20:42.02256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.269041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:20:42.022651Z","caller":"traceutil/trace.go:171","msg":"trace[698496774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8563; }","duration":"210.431904ms","start":"2026-10-17T10:20:41.812199Z","end":"2026-10-17T10:20:42.022631Z","steps":["trace[698496774] 'agreement among raft nodes before linearized reading' (duration: 210.283131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:42.022686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.18154ms","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-17T10:20:42.022788Z","caller":"traceutil/trace.go:171","msg":"trace[574513962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8563; }","duration":"368.342093ms","start":"2026-10-17T10:20:41.654418Z","end":"2026-10-17T10:20:42.02276Z","steps":["trace[574513962] 'agreement among raft nodes before linearized reading' (duration: 368.049627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:42.022862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:20:41.654388Z","time spent":"368.462576ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T10:20:42.022606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:20:41.632184Z","time spent":"390.268363ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:20:45.650713Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022c4.wal"} {"level":"info","ts":"2026-10-17T10:21:10.569745Z","caller":"traceutil/trace.go:171","msg":"trace[289866434] linearizableReadLoop","detail":"{readStateIndex:9085; appliedIndex:9084; }","duration":"316.147256ms","start":"2026-10-17T10:21:10.253582Z","end":"2026-10-17T10:21:10.569729Z","steps":["trace[289866434] 'read index received' (duration: 315.985772ms)","trace[289866434] 'applied index is now lower than readState.Index' (duration: 160.684µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:10.569853Z","caller":"traceutil/trace.go:171","msg":"trace[1301203592] transaction","detail":"{read_only:false; response_revision:8769; number_of_response:1; }","duration":"322.307688ms","start":"2026-10-17T10:21:10.247488Z","end":"2026-10-17T10:21:10.569796Z","steps":["trace[1301203592] 'process raft request' (duration: 322.127334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.569968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.37077ms","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-10-17T10:21:10.569996Z","caller":"traceutil/trace.go:171","msg":"trace[519063765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8769; }","duration":"315.451811ms","start":"2026-10-17T10:21:10.254538Z","end":"2026-10-17T10:21:10.56999Z","steps":["trace[519063765] 'agreement among raft nodes before linearized reading' (duration: 315.287977ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.57002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:21:10.254512Z","time spent":"315.503493ms","remote":"127.0.0.1:41380","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-10-17T10:21:10.570037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:21:10.247464Z","time spent":"322.470212ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:21:10.570148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.567225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-17T10:21:10.570116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.142714ms","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-10-17T10:21:10.57017Z","caller":"traceutil/trace.go:171","msg":"trace[1215659441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8769; }","duration":"316.617257ms","start":"2026-10-17T10:21:10.253548Z","end":"2026-10-17T10:21:10.570165Z","steps":["trace[1215659441] 'agreement among raft nodes before linearized reading' (duration: 316.271689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.570184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:21:10.253534Z","time spent":"316.646167ms","remote":"127.0.0.1:41380","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":"info","ts":"2026-10-17T10:21:10.5702Z","caller":"traceutil/trace.go:171","msg":"trace[565866793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8769; }","duration":"129.267287ms","start":"2026-10-17T10:21:10.440911Z","end":"2026-10-17T10:21:10.570178Z","steps":["trace[565866793] 'agreement among raft nodes before linearized reading' (duration: 129.007111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.570204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.033583ms","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-10-17T10:21:10.5705Z","caller":"traceutil/trace.go:171","msg":"trace[1938560332] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8769; }","duration":"130.31789ms","start":"2026-10-17T10:21:10.440098Z","end":"2026-10-17T10:21:10.570416Z","steps":["trace[1938560332] 'agreement among raft nodes before linearized reading' (duration: 129.84043ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.831992Z","caller":"traceutil/trace.go:171","msg":"trace[1940192193] transaction","detail":"{read_only:false; response_revision:8770; number_of_response:1; }","duration":"256.828046ms","start":"2026-10-17T10:21:10.575126Z","end":"2026-10-17T10:21:10.831954Z","steps":["trace[1940192193] 'process raft request' (duration: 237.86673ms)","trace[1940192193] 'compare' (duration: 18.644109ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:10.835146Z","caller":"traceutil/trace.go:171","msg":"trace[722246553] linearizableReadLoop","detail":"{readStateIndex:9090; appliedIndex:9085; }","duration":"174.180138ms","start":"2026-10-17T10:21:10.660942Z","end":"2026-10-17T10:21:10.835122Z","steps":["trace[722246553] 'read index received' (duration: 152.100656ms)","trace[722246553] 'applied index is now lower than readState.Index' (duration: 22.078432ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:10.835521Z","caller":"traceutil/trace.go:171","msg":"trace[1235500441] transaction","detail":"{read_only:false; response_revision:8771; number_of_response:1; }","duration":"260.345052ms","start":"2026-10-17T10:21:10.575157Z","end":"2026-10-17T10:21:10.835502Z","steps":["trace[1235500441] 'process raft request' (duration: 259.715017ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.83631Z","caller":"traceutil/trace.go:171","msg":"trace[956345039] transaction","detail":"{read_only:false; response_revision:8773; number_of_response:1; }","duration":"260.785401ms","start":"2026-10-17T10:21:10.575511Z","end":"2026-10-17T10:21:10.836297Z","steps":["trace[956345039] 'process raft request' (duration: 259.526125ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.836056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.056907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vglrq\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-17T10:21:10.836379Z","caller":"traceutil/trace.go:171","msg":"trace[168728217] transaction","detail":"{read_only:false; response_revision:8774; number_of_response:1; }","duration":"258.611256ms","start":"2026-10-17T10:21:10.577747Z","end":"2026-10-17T10:21:10.836358Z","steps":["trace[168728217] 'process raft request' (duration: 257.327589ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.836397Z","caller":"traceutil/trace.go:171","msg":"trace[1812787345] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vglrq; range_end:; response_count:1; response_revision:8774; }","duration":"175.435695ms","start":"2026-10-17T10:21:10.660934Z","end":"2026-10-17T10:21:10.836369Z","steps":["trace[1812787345] 'agreement among raft nodes before linearized reading' (duration: 174.74084ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.836509Z","caller":"traceutil/trace.go:171","msg":"trace[1123508219] transaction","detail":"{read_only:false; response_revision:8772; number_of_response:1; }","duration":"260.985906ms","start":"2026-10-17T10:21:10.575512Z","end":"2026-10-17T10:21:10.836498Z","steps":["trace[1123508219] 'process raft request' (duration: 259.475393ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:14.447586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.136811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:21:14.447663Z","caller":"traceutil/trace.go:171","msg":"trace[1832369056] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8788; }","duration":"105.264093ms","start":"2026-10-17T10:21:14.34238Z","end":"2026-10-17T10:21:14.447644Z","steps":["trace[1832369056] 'count revisions from in-memory index tree' (duration: 105.019677ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:23.069119Z","caller":"traceutil/trace.go:171","msg":"trace[2037650841] transaction","detail":"{read_only:false; response_revision:8834; number_of_response:1; }","duration":"118.556008ms","start":"2026-10-17T10:21:22.950539Z","end":"2026-10-17T10:21:23.069095Z","steps":["trace[2037650841] 'process raft request' (duration: 118.365074ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:23.069372Z","caller":"traceutil/trace.go:171","msg":"trace[791603696] transaction","detail":"{read_only:false; response_revision:8835; number_of_response:1; }","duration":"118.187729ms","start":"2026-10-17T10:21:22.951163Z","end":"2026-10-17T10:21:23.06935Z","steps":["trace[791603696] 'process raft request' (duration: 117.895663ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:23.069432Z","caller":"traceutil/trace.go:171","msg":"trace[1044271622] transaction","detail":"{read_only:false; response_revision:8836; number_of_response:1; }","duration":"118.073007ms","start":"2026-10-17T10:21:22.951335Z","end":"2026-10-17T10:21:23.069408Z","steps":["trace[1044271622] 'process raft request' (duration: 117.931884ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:23.069511Z","caller":"traceutil/trace.go:171","msg":"trace[947501378] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"117.180928ms","start":"2026-10-17T10:21:22.95232Z","end":"2026-10-17T10:21:23.069501Z","steps":["trace[947501378] 'process raft request' (duration: 117.037054ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:23.069511Z","caller":"traceutil/trace.go:171","msg":"trace[1779058557] linearizableReadLoop","detail":"{readStateIndex:9152; appliedIndex:9150; }","duration":"118.517567ms","start":"2026-10-17T10:21:22.950981Z","end":"2026-10-17T10:21:23.069498Z","steps":["trace[1779058557] 'read index received' (duration: 87.177316ms)","trace[1779058557] 'applied index is now lower than readState.Index' (duration: 31.339051ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:21:23.070206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.203912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228844"} {"level":"info","ts":"2026-10-17T10:21:23.070253Z","caller":"traceutil/trace.go:171","msg":"trace[689358702] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8837; }","duration":"119.282152ms","start":"2026-10-17T10:21:22.950958Z","end":"2026-10-17T10:21:23.070241Z","steps":["trace[689358702] 'agreement among raft nodes before linearized reading' (duration: 118.609768ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:22:45.502426Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T10:22:45.513964Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T10:22:45.514087Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T10:22:53.35579Z","caller":"traceutil/trace.go:171","msg":"trace[110759294] transaction","detail":"{read_only:false; response_revision:9698; number_of_response:1; }","duration":"216.368314ms","start":"2026-10-17T10:22:53.139396Z","end":"2026-10-17T10:22:53.355764Z","steps":["trace[110759294] 'process raft request' (duration: 216.225541ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:24:41.126286Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8057} {"level":"info","ts":"2026-10-17T10:24:41.196133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8057,"took":"67.758708ms","hash":1585898888,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":28274688,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:24:41.196196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1585898888,"revision":8057,"compact-revision":5887} {"level":"info","ts":"2026-10-17T10:28:31.310998Z","caller":"traceutil/trace.go:171","msg":"trace[2038611830] linearizableReadLoop","detail":"{readStateIndex:12548; appliedIndex:12547; }","duration":"133.731425ms","start":"2026-10-17T10:28:31.177242Z","end":"2026-10-17T10:28:31.310973Z","steps":["trace[2038611830] 'read index received' (duration: 133.489279ms)","trace[2038611830] 'applied index is now lower than readState.Index' (duration: 240.795µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:28:31.311045Z","caller":"traceutil/trace.go:171","msg":"trace[794051585] transaction","detail":"{read_only:false; response_revision:12124; number_of_response:1; }","duration":"137.317691ms","start":"2026-10-17T10:28:31.173702Z","end":"2026-10-17T10:28:31.311019Z","steps":["trace[794051585] 'process raft request' (duration: 137.090646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:28:31.311218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.960318ms","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-10-17T10:28:31.311258Z","caller":"traceutil/trace.go:171","msg":"trace[1132317790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12124; }","duration":"134.011599ms","start":"2026-10-17T10:28:31.177234Z","end":"2026-10-17T10:28:31.311246Z","steps":["trace[1132317790] 'agreement among raft nodes before linearized reading' (duration: 133.879007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:28:31.311409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.701383ms","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-17T10:28:31.311491Z","caller":"traceutil/trace.go:171","msg":"trace[850620425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12124; }","duration":"132.873055ms","start":"2026-10-17T10:28:31.1786Z","end":"2026-10-17T10:28:31.311473Z","steps":["trace[850620425] 'agreement among raft nodes before linearized reading' (duration: 132.566939ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:29:41.132729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10437} {"level":"info","ts":"2026-10-17T10:29:41.219744Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10437,"took":"84.458702ms","hash":2851060353,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":26025984,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T10:29:41.219814Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2851060353,"revision":10437,"compact-revision":8057} {"level":"info","ts":"2026-10-17T10:34:38.774403Z","caller":"traceutil/trace.go:171","msg":"trace[1962355939] transaction","detail":"{read_only:false; response_revision:14613; number_of_response:1; }","duration":"132.881654ms","start":"2026-10-17T10:34:38.641486Z","end":"2026-10-17T10:34:38.774367Z","steps":["trace[1962355939] 'process raft request' (duration: 99.300998ms)","trace[1962355939] 'compare' (duration: 33.291589ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:34:41.140686Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12603} {"level":"info","ts":"2026-10-17T10:34:41.219242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12603,"took":"76.301147ms","hash":3449349220,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":27455488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:34:41.219312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3449349220,"revision":12603,"compact-revision":10437} {"level":"info","ts":"2026-10-17T10:35:02.209879Z","caller":"traceutil/trace.go:171","msg":"trace[1519323429] transaction","detail":"{read_only:false; response_revision:14738; number_of_response:1; }","duration":"161.961024ms","start":"2026-10-17T10:35:02.04787Z","end":"2026-10-17T10:35:02.209831Z","steps":["trace[1519323429] 'process raft request' (duration: 161.80669ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:19.798685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.389045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:35:19.799049Z","caller":"traceutil/trace.go:171","msg":"trace[1500026393] transaction","detail":"{read_only:false; response_revision:14841; number_of_response:1; }","duration":"419.946885ms","start":"2026-10-17T10:35:19.379073Z","end":"2026-10-17T10:35:19.79902Z","steps":["trace[1500026393] 'process raft request' (duration: 263.111991ms)","trace[1500026393] 'compare' (duration: 156.179351ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:35:19.799141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:19.379039Z","time spent":"420.055678ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:35:19.798934Z","caller":"traceutil/trace.go:171","msg":"trace[727235477] linearizableReadLoop","detail":"{readStateIndex:15362; appliedIndex:15361; }","duration":"329.403514ms","start":"2026-10-17T10:35:19.469493Z","end":"2026-10-17T10:35:19.798896Z","steps":["trace[727235477] 'read index received' (duration: 172.710313ms)","trace[727235477] 'applied index is now lower than readState.Index' (duration: 156.691291ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:35:19.800152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.644802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vglrq\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-17T10:35:19.800277Z","caller":"traceutil/trace.go:171","msg":"trace[739949097] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vglrq; range_end:; response_count:1; response_revision:14841; }","duration":"330.778865ms","start":"2026-10-17T10:35:19.469439Z","end":"2026-10-17T10:35:19.800218Z","steps":["trace[739949097] 'agreement among raft nodes before linearized reading' (duration: 329.948697ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:19.800327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:19.469417Z","time spent":"330.898537ms","remote":"127.0.0.1:41290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-vglrq\" "} {"level":"warn","ts":"2026-10-17T10:35:19.81572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.355107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-17T10:35:19.81575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.932607ms","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-10-17T10:35:19.815811Z","caller":"traceutil/trace.go:171","msg":"trace[762917815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14841; }","duration":"264.48826ms","start":"2026-10-17T10:35:19.551298Z","end":"2026-10-17T10:35:19.815786Z","steps":["trace[762917815] 'agreement among raft nodes before linearized reading' (duration: 264.271325ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:35:19.815822Z","caller":"traceutil/trace.go:171","msg":"trace[1098856008] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14841; }","duration":"256.057881ms","start":"2026-10-17T10:35:19.55974Z","end":"2026-10-17T10:35:19.815798Z","steps":["trace[1098856008] 'agreement among raft nodes before linearized reading' (duration: 255.812486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:19.815888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.60397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T10:35:19.815975Z","caller":"traceutil/trace.go:171","msg":"trace[1603162716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14841; }","duration":"269.734332ms","start":"2026-10-17T10:35:19.546215Z","end":"2026-10-17T10:35:19.81595Z","steps":["trace[1603162716] 'agreement among raft nodes before linearized reading' (duration: 269.445356ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:35:42.66917Z","caller":"traceutil/trace.go:171","msg":"trace[501803544] transaction","detail":"{read_only:false; response_revision:15155; number_of_response:1; }","duration":"313.647218ms","start":"2026-10-17T10:35:42.355474Z","end":"2026-10-17T10:35:42.669121Z","steps":["trace[501803544] 'process raft request' (duration: 313.448444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:42.669362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:42.355453Z","time spent":"313.806202ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:35:42.69833Z","caller":"traceutil/trace.go:171","msg":"trace[1607947919] linearizableReadLoop","detail":"{readStateIndex:15689; appliedIndex:15687; }","duration":"192.357562ms","start":"2026-10-17T10:35:42.505946Z","end":"2026-10-17T10:35:42.698304Z","steps":["trace[1607947919] 'read index received' (duration: 163.013766ms)","trace[1607947919] 'applied index is now lower than readState.Index' (duration: 29.342536ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:35:42.698416Z","caller":"traceutil/trace.go:171","msg":"trace[50502853] transaction","detail":"{read_only:false; response_revision:15156; number_of_response:1; }","duration":"275.479295ms","start":"2026-10-17T10:35:42.422901Z","end":"2026-10-17T10:35:42.698381Z","steps":["trace[50502853] 'process raft request' (duration: 267.167078ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:42.699009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.72944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be3f9915-e1d7-41b8-8bff-2215aee2c1e1\" ","response":"range_response_count:1 size:3636"} {"level":"info","ts":"2026-10-17T10:35:42.699122Z","caller":"traceutil/trace.go:171","msg":"trace[1607449851] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be3f9915-e1d7-41b8-8bff-2215aee2c1e1; range_end:; response_count:1; response_revision:15156; }","duration":"193.19157ms","start":"2026-10-17T10:35:42.505908Z","end":"2026-10-17T10:35:42.699099Z","steps":["trace[1607449851] 'agreement among raft nodes before linearized reading' (duration: 192.508336ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:36:54.522563Z","caller":"traceutil/trace.go:171","msg":"trace[1860613633] linearizableReadLoop","detail":"{readStateIndex:16446; appliedIndex:16445; }","duration":"197.178428ms","start":"2026-10-17T10:36:54.325355Z","end":"2026-10-17T10:36:54.522533Z","steps":["trace[1860613633] 'read index received' (duration: 196.976163ms)","trace[1860613633] 'applied index is now lower than readState.Index' (duration: 201.065µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:36:54.52288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.489123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-17T10:36:54.522911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.285147ms","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-10-17T10:36:54.522931Z","caller":"traceutil/trace.go:171","msg":"trace[533018169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15893; }","duration":"197.613546ms","start":"2026-10-17T10:36:54.325301Z","end":"2026-10-17T10:36:54.522915Z","steps":["trace[533018169] 'agreement among raft nodes before linearized reading' (duration: 197.416602ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:36:54.522963Z","caller":"traceutil/trace.go:171","msg":"trace[911127869] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15893; }","duration":"195.364958ms","start":"2026-10-17T10:36:54.327584Z","end":"2026-10-17T10:36:54.522949Z","steps":["trace[911127869] 'agreement among raft nodes before linearized reading' (duration: 195.185705ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:36:54.522606Z","caller":"traceutil/trace.go:171","msg":"trace[284326521] transaction","detail":"{read_only:false; response_revision:15893; number_of_response:1; }","duration":"261.071311ms","start":"2026-10-17T10:36:54.261511Z","end":"2026-10-17T10:36:54.522583Z","steps":["trace[284326521] 'process raft request' (duration: 260.871446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:36:54.523012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.627171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-17T10:36:54.523167Z","caller":"traceutil/trace.go:171","msg":"trace[1901434188] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15893; }","duration":"103.812524ms","start":"2026-10-17T10:36:54.41934Z","end":"2026-10-17T10:36:54.523153Z","steps":["trace[1901434188] 'agreement among raft nodes before linearized reading' (duration: 103.481857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:36:54.523257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.560581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:36:54.523308Z","caller":"traceutil/trace.go:171","msg":"trace[955598721] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15893; }","duration":"104.630142ms","start":"2026-10-17T10:36:54.418663Z","end":"2026-10-17T10:36:54.523293Z","steps":["trace[955598721] 'agreement among raft nodes before linearized reading' (duration: 104.547021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:36:54.523464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.284345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-17T10:36:54.523502Z","caller":"traceutil/trace.go:171","msg":"trace[1021492878] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15893; }","duration":"104.339476ms","start":"2026-10-17T10:36:54.419154Z","end":"2026-10-17T10:36:54.523493Z","steps":["trace[1021492878] 'agreement among raft nodes before linearized reading' (duration: 104.242124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:36:54.523597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.051357ms","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-17T10:36:54.523671Z","caller":"traceutil/trace.go:171","msg":"trace[260813565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15893; }","duration":"168.145717ms","start":"2026-10-17T10:36:54.355499Z","end":"2026-10-17T10:36:54.523645Z","steps":["trace[260813565] 'agreement among raft nodes before linearized reading' (duration: 167.988044ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:39:41.152347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14628} {"level":"info","ts":"2026-10-17T10:39:41.233703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14628,"took":"78.192619ms","hash":1649618228,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":32129024,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T10:39:41.233809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1649618228,"revision":14628,"compact-revision":12603} {"level":"info","ts":"2026-10-17T10:43:05.132458Z","caller":"traceutil/trace.go:171","msg":"trace[1382649123] transaction","detail":"{read_only:false; response_revision:18586; number_of_response:1; }","duration":"234.722592ms","start":"2026-10-17T10:43:04.897716Z","end":"2026-10-17T10:43:05.132439Z","steps":["trace[1382649123] 'process raft request' (duration: 234.603359ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:05.13367Z","caller":"traceutil/trace.go:171","msg":"trace[1491900238] transaction","detail":"{read_only:false; response_revision:18587; number_of_response:1; }","duration":"224.281369ms","start":"2026-10-17T10:43:04.909364Z","end":"2026-10-17T10:43:05.133646Z","steps":["trace[1491900238] 'process raft request' (duration: 224.121985ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:05.133934Z","caller":"traceutil/trace.go:171","msg":"trace[1338842643] transaction","detail":"{read_only:false; response_revision:18588; number_of_response:1; }","duration":"107.194858ms","start":"2026-10-17T10:43:05.026729Z","end":"2026-10-17T10:43:05.133924Z","steps":["trace[1338842643] 'process raft request' (duration: 106.876952ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:12.845854Z","caller":"traceutil/trace.go:171","msg":"trace[410466850] transaction","detail":"{read_only:false; response_revision:18631; number_of_response:1; }","duration":"299.871443ms","start":"2026-10-17T10:43:12.545959Z","end":"2026-10-17T10:43:12.84583Z","steps":["trace[410466850] 'process raft request' (duration: 299.68218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:12.84605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:12.545951Z","time spent":"300.011606ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:43:12.846105Z","caller":"traceutil/trace.go:171","msg":"trace[349284902] linearizableReadLoop","detail":"{readStateIndex:19276; appliedIndex:19273; }","duration":"265.664533ms","start":"2026-10-17T10:43:12.580407Z","end":"2026-10-17T10:43:12.846072Z","steps":["trace[349284902] 'read index received' (duration: 50.597341ms)","trace[349284902] 'applied index is now lower than readState.Index' (duration: 215.064551ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:43:12.846209Z","caller":"traceutil/trace.go:171","msg":"trace[1294246420] transaction","detail":"{read_only:false; response_revision:18632; number_of_response:1; }","duration":"299.839463ms","start":"2026-10-17T10:43:12.546312Z","end":"2026-10-17T10:43:12.846152Z","steps":["trace[1294246420] 'process raft request' (duration: 299.474074ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:12.846327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.307325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-17T10:43:12.846327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.931198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-c4dw6\" ","response":"range_response_count:1 size:20743"} {"level":"info","ts":"2026-10-17T10:43:12.846374Z","caller":"traceutil/trace.go:171","msg":"trace[1753484118] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:18632; }","duration":"162.437159ms","start":"2026-10-17T10:43:12.683924Z","end":"2026-10-17T10:43:12.846361Z","steps":["trace[1753484118] 'agreement among raft nodes before linearized reading' (duration: 162.318996ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:12.84639Z","caller":"traceutil/trace.go:171","msg":"trace[2002427460] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-c4dw6; range_end:; response_count:1; response_revision:18632; }","duration":"266.051401ms","start":"2026-10-17T10:43:12.580318Z","end":"2026-10-17T10:43:12.846369Z","steps":["trace[2002427460] 'agreement among raft nodes before linearized reading' (duration: 265.883777ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:12.846464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:12.546288Z","time spent":"300.047747ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:43:13.396731Z","caller":"traceutil/trace.go:171","msg":"trace[674355671] transaction","detail":"{read_only:false; response_revision:18633; number_of_response:1; }","duration":"529.22997ms","start":"2026-10-17T10:43:12.867464Z","end":"2026-10-17T10:43:13.396694Z","steps":["trace[674355671] 'process raft request' (duration: 510.605583ms)","trace[674355671] 'compare' (duration: 18.460684ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:43:13.396958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:12.867414Z","time spent":"529.403184ms","remote":"127.0.0.1:41290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20860,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:43:13.488253Z","caller":"traceutil/trace.go:171","msg":"trace[894406555] transaction","detail":"{read_only:false; response_revision:18634; number_of_response:1; }","duration":"334.253728ms","start":"2026-10-17T10:43:13.153966Z","end":"2026-10-17T10:43:13.488219Z","steps":["trace[894406555] 'process raft request' (duration: 333.982352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:13.48844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:13.153935Z","time spent":"334.4ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:43:13.48858Z","caller":"traceutil/trace.go:171","msg":"trace[762037286] transaction","detail":"{read_only:false; response_revision:18637; number_of_response:1; }","duration":"312.38251ms","start":"2026-10-17T10:43:13.176171Z","end":"2026-10-17T10:43:13.488554Z","steps":["trace[762037286] 'process raft request' (duration: 312.330229ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:13.48864Z","caller":"traceutil/trace.go:171","msg":"trace[1797925253] transaction","detail":"{read_only:false; response_revision:18635; number_of_response:1; }","duration":"313.944463ms","start":"2026-10-17T10:43:13.174662Z","end":"2026-10-17T10:43:13.488606Z","steps":["trace[1797925253] 'process raft request' (duration: 313.510393ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:13.488734Z","caller":"traceutil/trace.go:171","msg":"trace[1703836867] transaction","detail":"{read_only:false; response_revision:18636; number_of_response:1; }","duration":"313.904193ms","start":"2026-10-17T10:43:13.174747Z","end":"2026-10-17T10:43:13.488651Z","steps":["trace[1703836867] 'process raft request' (duration: 313.661167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:13.488821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:13.174643Z","time spent":"314.105077ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:43:13.488819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:13.176161Z","time spent":"312.575415ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:43:13.489048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:13.174733Z","time spent":"314.156408ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:43:23.644057Z","caller":"traceutil/trace.go:171","msg":"trace[143116350] transaction","detail":"{read_only:false; response_revision:18840; number_of_response:1; }","duration":"113.033524ms","start":"2026-10-17T10:43:23.530998Z","end":"2026-10-17T10:43:23.644031Z","steps":["trace[143116350] 'process raft request' (duration: 112.622635ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:23.762709Z","caller":"traceutil/trace.go:171","msg":"trace[929225331] transaction","detail":"{read_only:false; response_revision:18841; number_of_response:1; }","duration":"228.151531ms","start":"2026-10-17T10:43:23.534534Z","end":"2026-10-17T10:43:23.762686Z","steps":["trace[929225331] 'process raft request' (duration: 214.394947ms)","trace[929225331] 'compare' (duration: 13.594031ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:43:23.763154Z","caller":"traceutil/trace.go:171","msg":"trace[2096601305] transaction","detail":"{read_only:false; response_revision:18842; number_of_response:1; }","duration":"225.053025ms","start":"2026-10-17T10:43:23.538061Z","end":"2026-10-17T10:43:23.763114Z","steps":["trace[2096601305] 'process raft request' (duration: 224.585045ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:23.763581Z","caller":"traceutil/trace.go:171","msg":"trace[741789523] transaction","detail":"{read_only:false; response_revision:18844; number_of_response:1; }","duration":"202.890213ms","start":"2026-10-17T10:43:23.560672Z","end":"2026-10-17T10:43:23.763562Z","steps":["trace[741789523] 'process raft request' (duration: 202.637207ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:23.763617Z","caller":"traceutil/trace.go:171","msg":"trace[503760594] transaction","detail":"{read_only:false; response_revision:18843; number_of_response:1; }","duration":"219.865025ms","start":"2026-10-17T10:43:23.543733Z","end":"2026-10-17T10:43:23.763598Z","steps":["trace[503760594] 'process raft request' (duration: 219.17635ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:44:14.566731Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T10:44:14.573763Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T10:44:14.573997Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T10:44:41.159738Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17078} {"level":"info","ts":"2026-10-17T10:44:41.261784Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17078,"took":"98.670677ms","hash":2579953478,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":33492992,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T10:44:41.261852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2579953478,"revision":17078,"compact-revision":14628} {"level":"info","ts":"2026-10-17T10:49:03.965587Z","caller":"traceutil/trace.go:171","msg":"trace[167700617] linearizableReadLoop","detail":"{readStateIndex:22081; appliedIndex:22080; }","duration":"194.903642ms","start":"2026-10-17T10:49:03.770655Z","end":"2026-10-17T10:49:03.965559Z","steps":["trace[167700617] 'read index received' (duration: 194.842391ms)","trace[167700617] 'applied index is now lower than readState.Index' (duration: 60.051µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:03.965714Z","caller":"traceutil/trace.go:171","msg":"trace[303737074] transaction","detail":"{read_only:false; response_revision:21347; number_of_response:1; }","duration":"195.242019ms","start":"2026-10-17T10:49:03.770462Z","end":"2026-10-17T10:49:03.965704Z","steps":["trace[303737074] 'process raft request' (duration: 194.941842ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:03.965957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.28198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19060"} {"level":"info","ts":"2026-10-17T10:49:03.965997Z","caller":"traceutil/trace.go:171","msg":"trace[1257493976] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21347; }","duration":"195.360131ms","start":"2026-10-17T10:49:03.770626Z","end":"2026-10-17T10:49:03.965987Z","steps":["trace[1257493976] 'agreement among raft nodes before linearized reading' (duration: 195.195517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:04.179893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.424965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:49:04.180018Z","caller":"traceutil/trace.go:171","msg":"trace[2013450575] linearizableReadLoop","detail":"{readStateIndex:22082; appliedIndex:22081; }","duration":"214.333007ms","start":"2026-10-17T10:49:03.965667Z","end":"2026-10-17T10:49:04.18Z","steps":["trace[2013450575] 'read index received' (duration: 75.640735ms)","trace[2013450575] 'applied index is now lower than readState.Index' (duration: 138.690942ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:04.180104Z","caller":"traceutil/trace.go:171","msg":"trace[1480554767] transaction","detail":"{read_only:false; response_revision:21348; number_of_response:1; }","duration":"405.426516ms","start":"2026-10-17T10:49:03.774627Z","end":"2026-10-17T10:49:04.180054Z","steps":["trace[1480554767] 'process raft request' (duration: 266.749336ms)","trace[1480554767] 'compare' (duration: 138.294763ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:49:04.180166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.41622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T10:49:04.18025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:03.774611Z","time spent":"405.57571ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:49:04.180264Z","caller":"traceutil/trace.go:171","msg":"trace[343470915] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:21348; }","duration":"334.570504ms","start":"2026-10-17T10:49:03.84567Z","end":"2026-10-17T10:49:04.18024Z","steps":["trace[343470915] 'agreement among raft nodes before linearized reading' (duration: 334.406661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:04.180126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.511245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T10:49:04.180319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:03.845648Z","time spent":"334.661086ms","remote":"127.0.0.1:54330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:49:04.180388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.539411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-10-17T10:49:04.180503Z","caller":"traceutil/trace.go:171","msg":"trace[201492098] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:21348; }","duration":"199.674683ms","start":"2026-10-17T10:49:03.980809Z","end":"2026-10-17T10:49:04.180484Z","steps":["trace[201492098] 'agreement among raft nodes before linearized reading' (duration: 199.293816ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:04.180403Z","caller":"traceutil/trace.go:171","msg":"trace[1711996995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21348; }","duration":"366.774851ms","start":"2026-10-17T10:49:03.813579Z","end":"2026-10-17T10:49:04.180354Z","steps":["trace[1711996995] 'agreement among raft nodes before linearized reading' (duration: 366.487405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:04.180645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:03.813569Z","time spent":"367.067137ms","remote":"127.0.0.1:41092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T10:49:14.647092Z","caller":"traceutil/trace.go:171","msg":"trace[1448905453] transaction","detail":"{read_only:false; response_revision:21402; number_of_response:1; }","duration":"100.511527ms","start":"2026-10-17T10:49:14.546557Z","end":"2026-10-17T10:49:14.647069Z","steps":["trace[1448905453] 'process raft request' (duration: 100.316252ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:20.14408Z","caller":"traceutil/trace.go:171","msg":"trace[1768188307] transaction","detail":"{read_only:false; response_revision:21429; number_of_response:1; }","duration":"119.081963ms","start":"2026-10-17T10:49:20.024973Z","end":"2026-10-17T10:49:20.144055Z","steps":["trace[1768188307] 'process raft request' (duration: 118.691044ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:20.484635Z","caller":"traceutil/trace.go:171","msg":"trace[2025963391] transaction","detail":"{read_only:false; response_revision:21430; number_of_response:1; }","duration":"145.009386ms","start":"2026-10-17T10:49:20.339589Z","end":"2026-10-17T10:49:20.484599Z","steps":["trace[2025963391] 'process raft request' (duration: 144.796021ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:20.637982Z","caller":"traceutil/trace.go:171","msg":"trace[673579603] transaction","detail":"{read_only:false; response_revision:21431; number_of_response:1; }","duration":"147.846666ms","start":"2026-10-17T10:49:20.490106Z","end":"2026-10-17T10:49:20.637952Z","steps":["trace[673579603] 'process raft request' (duration: 59.124442ms)","trace[673579603] 'compare' (duration: 88.557731ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:49:20.99139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.358948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:49:20.992063Z","caller":"traceutil/trace.go:171","msg":"trace[1842933823] transaction","detail":"{read_only:false; response_revision:21432; number_of_response:1; }","duration":"314.373293ms","start":"2026-10-17T10:49:20.677643Z","end":"2026-10-17T10:49:20.992016Z","steps":["trace[1842933823] 'process raft request' (duration: 113.174857ms)","trace[1842933823] 'compare' (duration: 199.647722ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:20.992112Z","caller":"traceutil/trace.go:171","msg":"trace[1851735747] linearizableReadLoop","detail":"{readStateIndex:22170; appliedIndex:22169; }","duration":"180.208697ms","start":"2026-10-17T10:49:20.811857Z","end":"2026-10-17T10:49:20.992065Z","steps":["trace[1851735747] 'read index received' (duration: 66.851µs)","trace[1851735747] 'applied index is now lower than readState.Index' (duration: 180.136396ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:49:20.992235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:20.677619Z","time spent":"314.531206ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:49:20.992372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.490943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T10:49:20.992413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.762996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:49:20.992468Z","caller":"traceutil/trace.go:171","msg":"trace[1714154243] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:21433; }","duration":"170.856818ms","start":"2026-10-17T10:49:20.821596Z","end":"2026-10-17T10:49:20.992452Z","steps":["trace[1714154243] 'agreement among raft nodes before linearized reading' (duration: 170.763376ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:20.992469Z","caller":"traceutil/trace.go:171","msg":"trace[1211387840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21433; }","duration":"180.637247ms","start":"2026-10-17T10:49:20.811803Z","end":"2026-10-17T10:49:20.992441Z","steps":["trace[1211387840] 'agreement among raft nodes before linearized reading' (duration: 180.402022ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:20.992537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.910076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T10:49:20.992591Z","caller":"traceutil/trace.go:171","msg":"trace[1832350517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21433; }","duration":"160.998887ms","start":"2026-10-17T10:49:20.831573Z","end":"2026-10-17T10:49:20.992572Z","steps":["trace[1832350517] 'agreement among raft nodes before linearized reading' (duration: 160.782143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:20.993001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.367258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T10:49:20.993058Z","caller":"traceutil/trace.go:171","msg":"trace[2032563941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21433; }","duration":"178.468811ms","start":"2026-10-17T10:49:20.814576Z","end":"2026-10-17T10:49:20.993045Z","steps":["trace[2032563941] 'agreement among raft nodes before linearized reading' (duration: 177.687974ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:21.141301Z","caller":"traceutil/trace.go:171","msg":"trace[523253409] transaction","detail":"{read_only:false; response_revision:21434; number_of_response:1; }","duration":"143.879962ms","start":"2026-10-17T10:49:20.997392Z","end":"2026-10-17T10:49:21.141272Z","steps":["trace[523253409] 'process raft request' (duration: 135.346119ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:21.347524Z","caller":"traceutil/trace.go:171","msg":"trace[1838855700] linearizableReadLoop","detail":"{readStateIndex:22175; appliedIndex:22172; }","duration":"139.764144ms","start":"2026-10-17T10:49:21.207731Z","end":"2026-10-17T10:49:21.347496Z","steps":["trace[1838855700] 'read index received' (duration: 116.088049ms)","trace[1838855700] 'applied index is now lower than readState.Index' (duration: 23.674495ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:21.347601Z","caller":"traceutil/trace.go:171","msg":"trace[1938568465] transaction","detail":"{read_only:false; response_revision:21436; number_of_response:1; }","duration":"293.857135ms","start":"2026-10-17T10:49:21.053681Z","end":"2026-10-17T10:49:21.347538Z","steps":["trace[1938568465] 'process raft request' (duration: 293.692722ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:21.34771Z","caller":"traceutil/trace.go:171","msg":"trace[660090457] transaction","detail":"{read_only:false; response_revision:21437; number_of_response:1; }","duration":"261.714728ms","start":"2026-10-17T10:49:21.085967Z","end":"2026-10-17T10:49:21.347681Z","steps":["trace[660090457] 'process raft request' (duration: 261.476452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:21.347753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.001249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:49:21.3478Z","caller":"traceutil/trace.go:171","msg":"trace[1346594816] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:21437; }","duration":"140.098462ms","start":"2026-10-17T10:49:21.207688Z","end":"2026-10-17T10:49:21.347786Z","steps":["trace[1346594816] 'agreement among raft nodes before linearized reading' (duration: 139.9998ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:21.347976Z","caller":"traceutil/trace.go:171","msg":"trace[1659980724] transaction","detail":"{read_only:false; response_revision:21435; number_of_response:1; }","duration":"350.250538ms","start":"2026-10-17T10:49:20.9977Z","end":"2026-10-17T10:49:21.347951Z","steps":["trace[1659980724] 'process raft request' (duration: 326.064943ms)","trace[1659980724] 'compare' (duration: 23.335798ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:49:21.348117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:20.997651Z","time spent":"350.376051ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:49:41.166569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19525} {"level":"info","ts":"2026-10-17T10:49:41.276136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19525,"took":"105.549833ms","hash":1070623834,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":29257728,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-17T10:49:41.276187Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1070623834,"revision":19525,"compact-revision":17078} {"level":"info","ts":"2026-10-17T10:53:33.309015Z","caller":"traceutil/trace.go:171","msg":"trace[747762745] transaction","detail":"{read_only:false; response_revision:23999; number_of_response:1; }","duration":"160.148136ms","start":"2026-10-17T10:53:33.148839Z","end":"2026-10-17T10:53:33.308987Z","steps":["trace[747762745] 'process raft request' (duration: 159.927621ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:53:53.39841Z","caller":"traceutil/trace.go:171","msg":"trace[265966732] transaction","detail":"{read_only:false; response_revision:24196; number_of_response:1; }","duration":"188.207836ms","start":"2026-10-17T10:53:53.210172Z","end":"2026-10-17T10:53:53.39838Z","steps":["trace[265966732] 'process raft request' (duration: 167.453333ms)","trace[265966732] 'compare' (duration: 20.602379ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:53:53.405064Z","caller":"traceutil/trace.go:171","msg":"trace[822712460] transaction","detail":"{read_only:false; response_revision:24197; number_of_response:1; }","duration":"190.198888ms","start":"2026-10-17T10:53:53.214821Z","end":"2026-10-17T10:53:53.405019Z","steps":["trace[822712460] 'process raft request' (duration: 189.733098ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:41.174314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21540} {"level":"info","ts":"2026-10-17T10:54:41.294533Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21540,"took":"116.147418ms","hash":2647798977,"current-db-size-bytes":57294848,"current-db-size":"57 MB","current-db-size-in-use-bytes":42184704,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-17T10:54:41.294606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2647798977,"revision":21540,"compact-revision":19525} {"level":"info","ts":"2026-10-17T10:55:57.876043Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066ce.wal"} {"level":"info","ts":"2026-10-17T10:57:21.570991Z","caller":"traceutil/trace.go:171","msg":"trace[1439625618] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"415.64256ms","start":"2026-10-17T10:57:21.155305Z","end":"2026-10-17T10:57:21.570947Z","steps":["trace[1439625618] 'process raft request' (duration: 415.458536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.571182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.155281Z","time spent":"415.799473ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:21.812235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.371933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:57:21.81241Z","caller":"traceutil/trace.go:171","msg":"trace[516536670] linearizableReadLoop","detail":"{readStateIndex:27078; appliedIndex:27075; }","duration":"380.640413ms","start":"2026-10-17T10:57:21.431752Z","end":"2026-10-17T10:57:21.812392Z","steps":["trace[516536670] 'read index received' (duration: 139.14704ms)","trace[516536670] 'applied index is now lower than readState.Index' (duration: 241.492163ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:21.812666Z","caller":"traceutil/trace.go:171","msg":"trace[1334283284] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"566.248552ms","start":"2026-10-17T10:57:21.246404Z","end":"2026-10-17T10:57:21.812653Z","steps":["trace[1334283284] 'process raft request' (duration: 344.365678ms)","trace[1334283284] 'compare' (duration: 221.243751ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:21.812736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.246365Z","time spent":"566.336925ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:21.813108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.517309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T10:57:21.813216Z","caller":"traceutil/trace.go:171","msg":"trace[1626685313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26206; }","duration":"141.687283ms","start":"2026-10-17T10:57:21.67151Z","end":"2026-10-17T10:57:21.813197Z","steps":["trace[1626685313] 'agreement among raft nodes before linearized reading' (duration: 141.403227ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:21.813208Z","caller":"traceutil/trace.go:171","msg":"trace[104463777] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"467.741692ms","start":"2026-10-17T10:57:21.34544Z","end":"2026-10-17T10:57:21.813182Z","steps":["trace[104463777] 'process raft request' (duration: 466.894893ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.813298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.554132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-17T10:57:21.813343Z","caller":"traceutil/trace.go:171","msg":"trace[1354180212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26206; }","duration":"381.655114ms","start":"2026-10-17T10:57:21.431678Z","end":"2026-10-17T10:57:21.813333Z","steps":["trace[1354180212] 'agreement among raft nodes before linearized reading' (duration: 381.507551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.813375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.431646Z","time spent":"381.722536ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-17T10:57:21.813355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.34542Z","time spent":"467.837453ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.262414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.305089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:57:22.262522Z","caller":"traceutil/trace.go:171","msg":"trace[488111160] transaction","detail":"{read_only:false; response_revision:26207; number_of_response:1; }","duration":"443.430792ms","start":"2026-10-17T10:57:21.819071Z","end":"2026-10-17T10:57:22.262502Z","steps":["trace[488111160] 'process raft request' (duration: 201.93743ms)","trace[488111160] 'compare' (duration: 240.551432ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:22.262581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.819055Z","time spent":"443.498003ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.578076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.356185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:57:22.578478Z","caller":"traceutil/trace.go:171","msg":"trace[158993500] linearizableReadLoop","detail":"{readStateIndex:27080; appliedIndex:27078; }","duration":"675.2978ms","start":"2026-10-17T10:57:21.903153Z","end":"2026-10-17T10:57:22.578451Z","steps":["trace[158993500] 'read index received' (duration: 117.966558ms)","trace[158993500] 'applied index is now lower than readState.Index' (duration: 557.330372ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:22.578587Z","caller":"traceutil/trace.go:171","msg":"trace[1848344382] transaction","detail":"{read_only:false; response_revision:26209; number_of_response:1; }","duration":"668.872883ms","start":"2026-10-17T10:57:21.909702Z","end":"2026-10-17T10:57:22.578574Z","steps":["trace[1848344382] 'process raft request' (duration: 668.568506ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.578676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.909681Z","time spent":"668.953904ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.578692Z","caller":"traceutil/trace.go:171","msg":"trace[1581094379] transaction","detail":"{read_only:false; response_revision:26208; number_of_response:1; }","duration":"759.492556ms","start":"2026-10-17T10:57:21.81916Z","end":"2026-10-17T10:57:22.578653Z","steps":["trace[1581094379] 'process raft request' (duration: 581.471078ms)","trace[1581094379] 'compare' (duration: 177.118649ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:22.578885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.819131Z","time spent":"759.653011ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.579061Z","caller":"traceutil/trace.go:171","msg":"trace[1929651866] transaction","detail":"{read_only:false; response_revision:26210; number_of_response:1; }","duration":"652.440052ms","start":"2026-10-17T10:57:21.926601Z","end":"2026-10-17T10:57:22.579041Z","steps":["trace[1929651866] 'process raft request' (duration: 651.768247ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.579151Z","caller":"traceutil/trace.go:171","msg":"trace[2132698922] transaction","detail":"{read_only:false; response_revision:26211; number_of_response:1; }","duration":"350.904188ms","start":"2026-10-17T10:57:22.228231Z","end":"2026-10-17T10:57:22.579135Z","steps":["trace[2132698922] 'process raft request' (duration: 350.185352ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.579178Z","caller":"traceutil/trace.go:171","msg":"trace[655024457] transaction","detail":"{read_only:false; response_revision:26212; number_of_response:1; }","duration":"284.446359ms","start":"2026-10-17T10:57:22.294704Z","end":"2026-10-17T10:57:22.57915Z","steps":["trace[655024457] 'process raft request' (duration: 284.315337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.579239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:22.228202Z","time spent":"350.99922ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.579126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.952404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T10:57:22.579345Z","caller":"traceutil/trace.go:171","msg":"trace[924529235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26211; }","duration":"676.23755ms","start":"2026-10-17T10:57:21.903096Z","end":"2026-10-17T10:57:22.579334Z","steps":["trace[924529235] 'agreement among raft nodes before linearized reading' (duration: 675.806611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.579392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.903075Z","time spent":"676.292282ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T10:57:22.579168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.926584Z","time spent":"652.544173ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.581555Z","caller":"traceutil/trace.go:171","msg":"trace[1056441601] transaction","detail":"{read_only:false; response_revision:26213; number_of_response:1; }","duration":"168.298061ms","start":"2026-10-17T10:57:22.413242Z","end":"2026-10-17T10:57:22.58154Z","steps":["trace[1056441601] 'process raft request' (duration: 168.218569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.659328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.762253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:57:22.659427Z","caller":"traceutil/trace.go:171","msg":"trace[1131394627] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:26214; }","duration":"415.950966ms","start":"2026-10-17T10:57:22.243455Z","end":"2026-10-17T10:57:22.659406Z","steps":["trace[1131394627] 'agreement among raft nodes before linearized reading' (duration: 415.739701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.65947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:22.243435Z","time spent":"416.025927ms","remote":"127.0.0.1:51476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:57:22.659432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.011049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T10:57:22.659562Z","caller":"traceutil/trace.go:171","msg":"trace[935614922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26214; }","duration":"709.195364ms","start":"2026-10-17T10:57:21.950341Z","end":"2026-10-17T10:57:22.659536Z","steps":["trace[935614922] 'agreement among raft nodes before linearized reading' (duration: 708.841566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.65962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.950326Z","time spent":"709.284825ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-17T10:57:22.695768Z","caller":"traceutil/trace.go:171","msg":"trace[1381141810] transaction","detail":"{read_only:false; response_revision:26215; number_of_response:1; }","duration":"109.552408ms","start":"2026-10-17T10:57:22.586185Z","end":"2026-10-17T10:57:22.695737Z","steps":["trace[1381141810] 'process raft request' (duration: 109.218251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.220352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.705695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:58:25.220589Z","caller":"traceutil/trace.go:171","msg":"trace[1648185968] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"401.237262ms","start":"2026-10-17T10:58:24.819298Z","end":"2026-10-17T10:58:25.220535Z","steps":["trace[1648185968] 'process raft request' (duration: 255.21189ms)","trace[1648185968] 'compare' (duration: 145.514931ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:25.220743Z","caller":"traceutil/trace.go:171","msg":"trace[582995473] transaction","detail":"{read_only:false; response_revision:26773; number_of_response:1; }","duration":"394.010637ms","start":"2026-10-17T10:58:24.826712Z","end":"2026-10-17T10:58:25.220723Z","steps":["trace[582995473] 'process raft request' (duration: 393.932135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.220776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.819279Z","time spent":"401.406555ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.220791Z","caller":"traceutil/trace.go:171","msg":"trace[193123645] transaction","detail":"{read_only:false; response_revision:26772; number_of_response:1; }","duration":"396.899209ms","start":"2026-10-17T10:58:24.823823Z","end":"2026-10-17T10:58:25.220723Z","steps":["trace[193123645] 'process raft request' (duration: 396.682534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.220846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.826698Z","time spent":"394.10433ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.221041Z","caller":"traceutil/trace.go:171","msg":"trace[1631245949] transaction","detail":"{read_only:false; response_revision:26774; number_of_response:1; }","duration":"336.205905ms","start":"2026-10-17T10:58:24.884789Z","end":"2026-10-17T10:58:25.220995Z","steps":["trace[1631245949] 'process raft request' (duration: 335.895718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.22103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.823801Z","time spent":"397.091773ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:25.221301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.884767Z","time spent":"336.41134ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.223066Z","caller":"traceutil/trace.go:171","msg":"trace[1046232305] linearizableReadLoop","detail":"{readStateIndex:27662; appliedIndex:27657; }","duration":"300.343271ms","start":"2026-10-17T10:58:24.92269Z","end":"2026-10-17T10:58:25.223034Z","steps":["trace[1046232305] 'read index received' (duration: 151.768405ms)","trace[1046232305] 'applied index is now lower than readState.Index' (duration: 148.573676ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:25.223319Z","caller":"traceutil/trace.go:171","msg":"trace[384492430] transaction","detail":"{read_only:false; response_revision:26775; number_of_response:1; }","duration":"330.708498ms","start":"2026-10-17T10:58:24.892536Z","end":"2026-10-17T10:58:25.223244Z","steps":["trace[384492430] 'process raft request' (duration: 330.356151ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.223398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.682759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T10:58:25.223468Z","caller":"traceutil/trace.go:171","msg":"trace[13217831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26775; }","duration":"300.807622ms","start":"2026-10-17T10:58:24.922648Z","end":"2026-10-17T10:58:25.223456Z","steps":["trace[13217831] 'agreement among raft nodes before linearized reading' (duration: 300.554656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.223506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.922634Z","time spent":"300.863203ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T10:58:25.223519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.892506Z","time spent":"330.877102ms","remote":"127.0.0.1:41122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:25.811596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.862571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:58:25.812726Z","caller":"traceutil/trace.go:171","msg":"trace[1112426405] linearizableReadLoop","detail":"{readStateIndex:27663; appliedIndex:27662; }","duration":"589.533623ms","start":"2026-10-17T10:58:25.22314Z","end":"2026-10-17T10:58:25.812674Z","steps":["trace[1112426405] 'read index received' (duration: 462.516156ms)","trace[1112426405] 'applied index is now lower than readState.Index' (duration: 127.013907ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:25.812728Z","caller":"traceutil/trace.go:171","msg":"trace[893669987] transaction","detail":"{read_only:false; response_revision:26776; number_of_response:1; }","duration":"722.479097ms","start":"2026-10-17T10:58:25.090203Z","end":"2026-10-17T10:58:25.812682Z","steps":["trace[893669987] 'process raft request' (duration: 595.41176ms)","trace[893669987] 'compare' (duration: 125.402852ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:25.812864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.561198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-17T10:58:25.812943Z","caller":"traceutil/trace.go:171","msg":"trace[1134302071] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:26776; }","duration":"638.688282ms","start":"2026-10-17T10:58:25.174221Z","end":"2026-10-17T10:58:25.812909Z","steps":["trace[1134302071] 'agreement among raft nodes before linearized reading' (duration: 638.457317ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.812913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.393828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-17T10:58:25.812985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.174197Z","time spent":"638.778204ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":176,"response size":32,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:58:25.812971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.09017Z","time spent":"722.686732ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.813021Z","caller":"traceutil/trace.go:171","msg":"trace[639031888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26776; }","duration":"770.559672ms","start":"2026-10-17T10:58:25.042437Z","end":"2026-10-17T10:58:25.812996Z","steps":["trace[639031888] 'agreement among raft nodes before linearized reading' (duration: 770.238005ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.813072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.042416Z","time spent":"770.647354ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T10:58:25.813343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.070975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T10:58:25.81347Z","caller":"traceutil/trace.go:171","msg":"trace[1498593125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26776; }","duration":"772.243429ms","start":"2026-10-17T10:58:25.041207Z","end":"2026-10-17T10:58:25.81345Z","steps":["trace[1498593125] 'agreement among raft nodes before linearized reading' (duration: 771.491973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.813572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.041182Z","time spent":"772.371731ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T10:58:26.125192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.091876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:58:26.125492Z","caller":"traceutil/trace.go:171","msg":"trace[619475555] transaction","detail":"{read_only:false; response_revision:26781; number_of_response:1; }","duration":"167.049651ms","start":"2026-10-17T10:58:25.958423Z","end":"2026-10-17T10:58:26.125473Z","steps":["trace[619475555] 'process raft request' (duration: 166.99895ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.125643Z","caller":"traceutil/trace.go:171","msg":"trace[1221746447] transaction","detail":"{read_only:false; response_revision:26780; number_of_response:1; }","duration":"298.967002ms","start":"2026-10-17T10:58:25.826668Z","end":"2026-10-17T10:58:26.125635Z","steps":["trace[1221746447] 'process raft request' (duration: 298.720936ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.125674Z","caller":"traceutil/trace.go:171","msg":"trace[1231575915] transaction","detail":"{read_only:false; response_revision:26779; number_of_response:1; }","duration":"307.525544ms","start":"2026-10-17T10:58:25.818116Z","end":"2026-10-17T10:58:26.125641Z","steps":["trace[1231575915] 'process raft request' (duration: 307.236937ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.125727Z","caller":"traceutil/trace.go:171","msg":"trace[1387517513] transaction","detail":"{read_only:false; response_revision:26778; number_of_response:1; }","duration":"307.599605ms","start":"2026-10-17T10:58:25.818119Z","end":"2026-10-17T10:58:26.125719Z","steps":["trace[1387517513] 'process raft request' (duration: 307.176936ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:26.125786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.818106Z","time spent":"307.644707ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:26.125765Z","caller":"traceutil/trace.go:171","msg":"trace[602991821] linearizableReadLoop","detail":"{readStateIndex:27664; appliedIndex:27663; }","duration":"312.915739ms","start":"2026-10-17T10:58:25.812816Z","end":"2026-10-17T10:58:26.125732Z","steps":["trace[602991821] 'read index received' (duration: 164.161579ms)","trace[602991821] 'applied index is now lower than readState.Index' (duration: 148.7506ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:26.125868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.680699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-17T10:58:26.126017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.118733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-10-17T10:58:26.126056Z","caller":"traceutil/trace.go:171","msg":"trace[719702450] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26781; }","duration":"900.204915ms","start":"2026-10-17T10:58:25.225841Z","end":"2026-10-17T10:58:26.126046Z","steps":["trace[719702450] 'agreement among raft nodes before linearized reading' (duration: 900.048382ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.126046Z","caller":"traceutil/trace.go:171","msg":"trace[495032192] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26781; }","duration":"651.880893ms","start":"2026-10-17T10:58:25.474112Z","end":"2026-10-17T10:58:26.125993Z","steps":["trace[495032192] 'agreement among raft nodes before linearized reading' (duration: 651.633187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:26.125872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.818094Z","time spent":"307.666957ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:26.126084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.225822Z","time spent":"900.255107ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-10-17T10:58:26.125686Z","caller":"traceutil/trace.go:171","msg":"trace[1185543330] transaction","detail":"{read_only:false; response_revision:26777; number_of_response:1; }","duration":"897.09875ms","start":"2026-10-17T10:58:25.228559Z","end":"2026-10-17T10:58:26.125658Z","steps":["trace[1185543330] 'process raft request' (duration: 748.405491ms)","trace[1185543330] 'compare' (duration: 147.927442ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:26.12619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.474083Z","time spent":"652.007506ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T10:58:26.126344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.228542Z","time spent":"897.678572ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:26.126317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.393521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:58:26.127041Z","caller":"traceutil/trace.go:171","msg":"trace[491959036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26781; }","duration":"315.164117ms","start":"2026-10-17T10:58:25.811857Z","end":"2026-10-17T10:58:26.127021Z","steps":["trace[491959036] 'agreement among raft nodes before linearized reading' (duration: 313.994432ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:26.128043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.811834Z","time spent":"316.189859ms","remote":"127.0.0.1:41082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:58:26.464356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.717144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:58:26.464597Z","caller":"traceutil/trace.go:171","msg":"trace[630935956] transaction","detail":"{read_only:false; response_revision:26782; number_of_response:1; }","duration":"407.605726ms","start":"2026-10-17T10:58:26.056966Z","end":"2026-10-17T10:58:26.464572Z","steps":["trace[630935956] 'process raft request' (duration: 262.562916ms)","trace[630935956] 'compare' (duration: 144.416877ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:26.464691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:26.056909Z","time spent":"407.73805ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:26.465125Z","caller":"traceutil/trace.go:171","msg":"trace[1679346671] transaction","detail":"{read_only:false; response_revision:26783; number_of_response:1; }","duration":"382.279288ms","start":"2026-10-17T10:58:26.082776Z","end":"2026-10-17T10:58:26.465055Z","steps":["trace[1679346671] 'process raft request' (duration: 381.673965ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.465224Z","caller":"traceutil/trace.go:171","msg":"trace[351064260] linearizableReadLoop","detail":"{readStateIndex:27670; appliedIndex:27668; }","duration":"336.865449ms","start":"2026-10-17T10:58:26.12833Z","end":"2026-10-17T10:58:26.465196Z","steps":["trace[351064260] 'read index received' (duration: 191.181874ms)","trace[351064260] 'applied index is now lower than readState.Index' (duration: 145.680075ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:26.465243Z","caller":"traceutil/trace.go:171","msg":"trace[1463094760] transaction","detail":"{read_only:false; response_revision:26784; number_of_response:1; }","duration":"334.884486ms","start":"2026-10-17T10:58:26.130336Z","end":"2026-10-17T10:58:26.46522Z","steps":["trace[1463094760] 'process raft request' (duration: 334.734933ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:26.465468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:26.082749Z","time spent":"382.49135ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:26.465516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.174466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-10-17T10:58:26.465519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:26.13032Z","time spent":"334.988149ms","remote":"127.0.0.1:41380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:26.465489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.267625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:58:26.465568Z","caller":"traceutil/trace.go:171","msg":"trace[1739066635] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:26784; }","duration":"337.276228ms","start":"2026-10-17T10:58:26.128277Z","end":"2026-10-17T10:58:26.465553Z","steps":["trace[1739066635] 'agreement among raft nodes before linearized reading' (duration: 337.073754ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.465589Z","caller":"traceutil/trace.go:171","msg":"trace[32572103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26784; }","duration":"336.43803ms","start":"2026-10-17T10:58:26.129131Z","end":"2026-10-17T10:58:26.46557Z","steps":["trace[32572103] 'agreement among raft nodes before linearized reading' (duration: 336.291047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:26.465618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:26.128256Z","time spent":"337.349399ms","remote":"127.0.0.1:41122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-10-17T10:58:26.46563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:26.129113Z","time spent":"336.508591ms","remote":"127.0.0.1:41092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T10:59:41.18108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24652} {"level":"info","ts":"2026-10-17T10:59:41.355649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24652,"took":"170.476103ms","hash":1611941905,"current-db-size-bytes":58142720,"current-db-size":"58 MB","current-db-size-in-use-bytes":35016704,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-17T10:59:41.355703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1611941905,"revision":24652,"compact-revision":21540} {"level":"info","ts":"2026-10-17T11:02:10.602388Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:02:10.620637Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:02:10.621017Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:04:41.191144Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27511} {"level":"info","ts":"2026-10-17T11:04:41.329669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27511,"took":"133.563626ms","hash":1953777138,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":36622336,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-17T11:04:41.329758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1953777138,"revision":27511,"compact-revision":24652} {"level":"info","ts":"2026-10-17T11:09:41.198588Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30272} {"level":"info","ts":"2026-10-17T11:09:41.355407Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30272,"took":"152.520518ms","hash":1669778360,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":30838784,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:09:41.355618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1669778360,"revision":30272,"compact-revision":27511} {"level":"info","ts":"2026-10-17T11:14:41.206778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32556} {"level":"info","ts":"2026-10-17T11:14:41.372223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32556,"took":"159.578268ms","hash":1895939720,"current-db-size-bytes":59604992,"current-db-size":"60 MB","current-db-size-in-use-bytes":30363648,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:14:41.37231Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1895939720,"revision":32556,"compact-revision":30272} {"level":"info","ts":"2026-10-17T11:19:41.244708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34790} {"level":"info","ts":"2026-10-17T11:19:41.415985Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34790,"took":"167.069438ms","hash":430117857,"current-db-size-bytes":59604992,"current-db-size":"60 MB","current-db-size-in-use-bytes":31678464,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:19:41.416042Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":430117857,"revision":34790,"compact-revision":32556} {"level":"info","ts":"2026-10-17T11:23:23.11801Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"64a80de7883e6886","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:23:23.123923Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T11:23:23.123997Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T11:24:41.254024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37083} {"level":"info","ts":"2026-10-17T11:24:41.398974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37083,"took":"138.042978ms","hash":1090619795,"current-db-size-bytes":60030976,"current-db-size":"60 MB","current-db-size-in-use-bytes":32108544,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:24:41.399062Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1090619795,"revision":37083,"compact-revision":34790} {"level":"info","ts":"2026-10-17T11:29:41.274027Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39362} {"level":"info","ts":"2026-10-17T11:29:41.412963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39362,"took":"134.343371ms","hash":1719384857,"current-db-size-bytes":60030976,"current-db-size":"60 MB","current-db-size-in-use-bytes":30425088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:29:41.413604Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1719384857,"revision":39362,"compact-revision":37083}