{"level":"warn","ts":"2026-03-31T20:21:10.045661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T20:21:10.045765Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.238: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://199.19.213.238:2380","--initial-cluster=instance=https://199.19.213.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.238: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-03-31T20:21:10.045847Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T20:21:10.045859Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-03-31T20:21:10.045891Z","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-03-31T20:21:10.046544Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"]} {"level":"info","ts":"2026-03-31T20:21:10.046642Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.238: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-03-31T20:21:10.05025Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.42666ms"} {"level":"info","ts":"2026-03-31T20:21:10.056651Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8cf6035374726417","cluster-id":"e837e6e114b087e2"} {"level":"info","ts":"2026-03-31T20:21:10.056718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T20:21:10.056741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 0"} {"level":"info","ts":"2026-03-31T20:21:10.056758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8cf6035374726417 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T20:21:10.056769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 1"} {"level":"info","ts":"2026-03-31T20:21:10.056811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"warn","ts":"2026-03-31T20:21:10.063889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T20:21:10.065238Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T20:21:10.06658Z","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-03-31T20:21:10.069368Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8cf6035374726417","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T20:21:10.07046Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8cf6035374726417","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T20:21:10.070395Z","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-03-31T20:21:10.070767Z","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-03-31T20:21:10.070787Z","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-03-31T20:21:10.070962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"info","ts":"2026-03-31T20:21:10.071058Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","added-peer-id":"8cf6035374726417","added-peer-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-03-31T20:21:10.073021Z","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-03-31T20:21:10.073169Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-03-31T20:21:10.073283Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-03-31T20:21:10.074449Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8cf6035374726417","initial-advertise-peer-urls":["https://199.19.213.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T20:21:10.074484Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T20:21:10.257082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T20:21:10.257229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T20:21:10.257368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgPreVoteResp from 8cf6035374726417 at term 1"} {"level":"info","ts":"2026-03-31T20:21:10.257444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became candidate at term 2"} {"level":"info","ts":"2026-03-31T20:21:10.257543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgVoteResp from 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-03-31T20:21:10.257663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became leader at term 2"} {"level":"info","ts":"2026-03-31T20:21:10.257738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8cf6035374726417 elected leader 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-03-31T20:21:10.258847Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8cf6035374726417","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.238:2379]}","request-path":"/0/members/8cf6035374726417/attributes","cluster-id":"e837e6e114b087e2","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T20:21:10.258924Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:21:10.259009Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:21:10.258953Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:21:10.259343Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T20:21:10.25943Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T20:21:10.260083Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:21:10.260238Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:21:10.260321Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:21:10.262285Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T20:21:10.263998Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.238:2379"} {"level":"info","ts":"2026-03-31T20:21:47.350302Z","caller":"traceutil/trace.go:171","msg":"trace[316040277] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"368.295759ms","start":"2026-03-31T20:21:46.981948Z","end":"2026-03-31T20:21:47.350244Z","steps":["trace[316040277] 'process raft request' (duration: 367.218421ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:21:47.351462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:21:46.981919Z","time spent":"368.70002ms","remote":"127.0.0.1:34608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:21:47.914315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.461502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T20:21:47.914576Z","caller":"traceutil/trace.go:171","msg":"trace[1732099473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"101.753579ms","start":"2026-03-31T20:21:47.812756Z","end":"2026-03-31T20:21:47.91451Z","steps":["trace[1732099473] 'range keys from in-memory index tree' (duration: 101.223087ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:21:48.172701Z","caller":"traceutil/trace.go:171","msg":"trace[1301525048] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"299.484411ms","start":"2026-03-31T20:21:47.873186Z","end":"2026-03-31T20:21:48.17267Z","steps":["trace[1301525048] 'process raft request' (duration: 298.748582ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:21:48.191249Z","caller":"traceutil/trace.go:171","msg":"trace[1985608264] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"272.054032ms","start":"2026-03-31T20:21:47.919159Z","end":"2026-03-31T20:21:48.191213Z","steps":["trace[1985608264] 'process raft request' (duration: 271.917867ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:21:49.649829Z","caller":"traceutil/trace.go:171","msg":"trace[1249547855] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"124.945138ms","start":"2026-03-31T20:21:49.524855Z","end":"2026-03-31T20:21:49.6498Z","steps":["trace[1249547855] 'process raft request' (duration: 124.684132ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:21:49.649831Z","caller":"traceutil/trace.go:171","msg":"trace[1612474615] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"124.326344ms","start":"2026-03-31T20:21:49.525478Z","end":"2026-03-31T20:21:49.649805Z","steps":["trace[1612474615] 'process raft request' (duration: 124.199701ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:04.58098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.667481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-246jr\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-03-31T20:22:04.581042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.327424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-31T20:22:04.581112Z","caller":"traceutil/trace.go:171","msg":"trace[1104951526] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-246jr; range_end:; response_count:1; response_revision:740; }","duration":"100.870608ms","start":"2026-03-31T20:22:04.480214Z","end":"2026-03-31T20:22:04.581084Z","steps":["trace[1104951526] 'range keys from in-memory index tree' (duration: 100.414665ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:22:04.581133Z","caller":"traceutil/trace.go:171","msg":"trace[586856725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"309.481418ms","start":"2026-03-31T20:22:04.271626Z","end":"2026-03-31T20:22:04.581108Z","steps":["trace[586856725] 'range keys from in-memory index tree' (duration: 309.075478ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:04.581173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:22:04.271602Z","time spent":"309.564761ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-31T20:22:29.347143Z","caller":"traceutil/trace.go:171","msg":"trace[428462929] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"187.654407ms","start":"2026-03-31T20:22:29.159458Z","end":"2026-03-31T20:22:29.347113Z","steps":["trace[428462929] 'process raft request' (duration: 187.448952ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:22:39.625894Z","caller":"traceutil/trace.go:171","msg":"trace[1053079034] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"231.692369ms","start":"2026-03-31T20:22:39.394156Z","end":"2026-03-31T20:22:39.625848Z","steps":["trace[1053079034] 'process raft request' (duration: 231.36308ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:40.074614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.5362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-31T20:22:40.081368Z","caller":"traceutil/trace.go:171","msg":"trace[2106218025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:960; }","duration":"264.667503ms","start":"2026-03-31T20:22:39.810013Z","end":"2026-03-31T20:22:40.07468Z","steps":["trace[2106218025] 'range keys from in-memory index tree' (duration: 264.340015ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:22:40.551499Z","caller":"traceutil/trace.go:171","msg":"trace[1383256143] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"470.096624ms","start":"2026-03-31T20:22:40.08137Z","end":"2026-03-31T20:22:40.551467Z","steps":["trace[1383256143] 'process raft request' (duration: 469.913589ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:40.551655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:22:40.081354Z","time spent":"470.222966ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:22:40.621968Z","caller":"traceutil/trace.go:171","msg":"trace[775173730] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:996; }","duration":"361.608734ms","start":"2026-03-31T20:22:40.260331Z","end":"2026-03-31T20:22:40.62194Z","steps":["trace[775173730] 'read index received' (duration: 291.026376ms)","trace[775173730] 'applied index is now lower than readState.Index' (duration: 70.581338ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:22:40.622109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.759977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:22:40.622147Z","caller":"traceutil/trace.go:171","msg":"trace[1979713713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"361.84325ms","start":"2026-03-31T20:22:40.260294Z","end":"2026-03-31T20:22:40.622137Z","steps":["trace[1979713713] 'agreement among raft nodes before linearized reading' (duration: 361.740767ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:40.622181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:22:40.260277Z","time spent":"361.89604ms","remote":"127.0.0.1:34516","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-03-31T20:22:40.622472Z","caller":"traceutil/trace.go:171","msg":"trace[1924431586] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"538.508054ms","start":"2026-03-31T20:22:40.083745Z","end":"2026-03-31T20:22:40.622253Z","steps":["trace[1924431586] 'process raft request' (duration: 537.54395ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:22:40.623145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:22:40.083718Z","time spent":"538.945815ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:23:06.950974Z","caller":"traceutil/trace.go:171","msg":"trace[726457307] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"294.564727ms","start":"2026-03-31T20:23:06.656349Z","end":"2026-03-31T20:23:06.950914Z","steps":["trace[726457307] 'process raft request' (duration: 294.382892ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:07.139416Z","caller":"traceutil/trace.go:171","msg":"trace[981807128] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"117.466882ms","start":"2026-03-31T20:23:07.02191Z","end":"2026-03-31T20:23:07.139377Z","steps":["trace[981807128] 'process raft request' (duration: 44.196675ms)","trace[981807128] 'compare' (duration: 72.99953ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:23:08.099202Z","caller":"traceutil/trace.go:171","msg":"trace[1051517320] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"152.17593ms","start":"2026-03-31T20:23:07.946978Z","end":"2026-03-31T20:23:08.099154Z","steps":["trace[1051517320] 'process raft request' (duration: 151.937834ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:24.928223Z","caller":"traceutil/trace.go:171","msg":"trace[422789674] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"404.937327ms","start":"2026-03-31T20:23:24.523234Z","end":"2026-03-31T20:23:24.928171Z","steps":["trace[422789674] 'process raft request' (duration: 404.607648ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:24.928583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:23:24.523197Z","time spent":"405.159762ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:23:25.359766Z","caller":"traceutil/trace.go:171","msg":"trace[1079000392] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"228.246171ms","start":"2026-03-31T20:23:25.131503Z","end":"2026-03-31T20:23:25.359749Z","steps":["trace[1079000392] 'read index received' (duration: 228.041016ms)","trace[1079000392] 'applied index is now lower than readState.Index' (duration: 204.475µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:23:25.359849Z","caller":"traceutil/trace.go:171","msg":"trace[1362124524] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"232.017827ms","start":"2026-03-31T20:23:25.127824Z","end":"2026-03-31T20:23:25.359842Z","steps":["trace[1362124524] 'process raft request' (duration: 231.775851ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:25.360023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.507837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-31T20:23:25.360049Z","caller":"traceutil/trace.go:171","msg":"trace[1565371311] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1167; }","duration":"228.58672ms","start":"2026-03-31T20:23:25.131454Z","end":"2026-03-31T20:23:25.360041Z","steps":["trace[1565371311] 'agreement among raft nodes before linearized reading' (duration: 228.472886ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:25.360134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.21152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-31T20:23:25.360151Z","caller":"traceutil/trace.go:171","msg":"trace[1411972669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1167; }","duration":"123.283943ms","start":"2026-03-31T20:23:25.236863Z","end":"2026-03-31T20:23:25.360147Z","steps":["trace[1411972669] 'agreement among raft nodes before linearized reading' (duration: 123.233701ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:37.614259Z","caller":"traceutil/trace.go:171","msg":"trace[2093772071] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"160.036992ms","start":"2026-03-31T20:23:37.45419Z","end":"2026-03-31T20:23:37.614227Z","steps":["trace[2093772071] 'read index received' (duration: 127.246273ms)","trace[2093772071] 'applied index is now lower than readState.Index' (duration: 32.789229ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:23:37.614411Z","caller":"traceutil/trace.go:171","msg":"trace[1426572316] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"164.702302ms","start":"2026-03-31T20:23:37.449694Z","end":"2026-03-31T20:23:37.614396Z","steps":["trace[1426572316] 'process raft request' (duration: 131.792951ms)","trace[1426572316] 'compare' (duration: 32.409149ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:23:37.61474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.518275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T20:23:37.614796Z","caller":"traceutil/trace.go:171","msg":"trace[471537991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"160.607437ms","start":"2026-03-31T20:23:37.454175Z","end":"2026-03-31T20:23:37.614782Z","steps":["trace[471537991] 'agreement among raft nodes before linearized reading' (duration: 160.408532ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:37.614933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.570197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-31T20:23:37.614959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.046457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-31T20:23:37.615007Z","caller":"traceutil/trace.go:171","msg":"trace[340641006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"155.682109ms","start":"2026-03-31T20:23:37.459306Z","end":"2026-03-31T20:23:37.614988Z","steps":["trace[340641006] 'agreement among raft nodes before linearized reading' (duration: 155.432183ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:37.615048Z","caller":"traceutil/trace.go:171","msg":"trace[857568055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"159.17991ms","start":"2026-03-31T20:23:37.455845Z","end":"2026-03-31T20:23:37.615025Z","steps":["trace[857568055] 'agreement among raft nodes before linearized reading' (duration: 158.882982ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:38.475379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.655093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:23:38.475488Z","caller":"traceutil/trace.go:171","msg":"trace[319342054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"215.814127ms","start":"2026-03-31T20:23:38.259647Z","end":"2026-03-31T20:23:38.475461Z","steps":["trace[319342054] 'range keys from in-memory index tree' (duration: 215.54463ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:38.475569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.505414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-31T20:23:38.475654Z","caller":"traceutil/trace.go:171","msg":"trace[2146570353] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1211; }","duration":"245.647289ms","start":"2026-03-31T20:23:38.229988Z","end":"2026-03-31T20:23:38.475635Z","steps":["trace[2146570353] 'range keys from in-memory index tree' (duration: 244.769675ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:38.660945Z","caller":"traceutil/trace.go:171","msg":"trace[1051730585] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"184.082475ms","start":"2026-03-31T20:23:38.476833Z","end":"2026-03-31T20:23:38.660916Z","steps":["trace[1051730585] 'read index received' (duration: 183.888881ms)","trace[1051730585] 'applied index is now lower than readState.Index' (duration: 192.244µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:23:38.661106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.240399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:23:38.661155Z","caller":"traceutil/trace.go:171","msg":"trace[1292375720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1212; }","duration":"184.339763ms","start":"2026-03-31T20:23:38.476801Z","end":"2026-03-31T20:23:38.661141Z","steps":["trace[1292375720] 'agreement among raft nodes before linearized reading' (duration: 184.219899ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:38.661461Z","caller":"traceutil/trace.go:171","msg":"trace[998976363] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"315.719733ms","start":"2026-03-31T20:23:38.345706Z","end":"2026-03-31T20:23:38.661426Z","steps":["trace[998976363] 'process raft request' (duration: 315.016555ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:23:38.661643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:23:38.345687Z","time spent":"315.864866ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:23:38.769654Z","caller":"traceutil/trace.go:171","msg":"trace[1320145520] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"289.054712ms","start":"2026-03-31T20:23:38.480572Z","end":"2026-03-31T20:23:38.769627Z","steps":["trace[1320145520] 'process raft request' (duration: 288.883777ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.461144Z","caller":"traceutil/trace.go:171","msg":"trace[1296030273] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"200.452459ms","start":"2026-03-31T20:23:39.26067Z","end":"2026-03-31T20:23:39.461122Z","steps":["trace[1296030273] 'process raft request' (duration: 199.762401ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.461528Z","caller":"traceutil/trace.go:171","msg":"trace[1558238181] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1264; }","duration":"113.487288ms","start":"2026-03-31T20:23:39.348029Z","end":"2026-03-31T20:23:39.461517Z","steps":["trace[1558238181] 'read index received' (duration: 113.482597ms)","trace[1558238181] 'applied index is now lower than readState.Index' (duration: 3.941µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:23:39.461683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.624431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:23:39.461727Z","caller":"traceutil/trace.go:171","msg":"trace[2009094998] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1214; }","duration":"113.725423ms","start":"2026-03-31T20:23:39.347991Z","end":"2026-03-31T20:23:39.461716Z","steps":["trace[2009094998] 'agreement among raft nodes before linearized reading' (duration: 113.608781ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.71221Z","caller":"traceutil/trace.go:171","msg":"trace[2039636626] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"273.287785ms","start":"2026-03-31T20:23:39.438897Z","end":"2026-03-31T20:23:39.712185Z","steps":["trace[2039636626] 'process raft request' (duration: 230.98453ms)","trace[2039636626] 'compare' (duration: 41.141175ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:23:39.712391Z","caller":"traceutil/trace.go:171","msg":"trace[1222722311] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1264; }","duration":"250.810052ms","start":"2026-03-31T20:23:39.461569Z","end":"2026-03-31T20:23:39.712379Z","steps":["trace[1222722311] 'read index received' (duration: 208.335192ms)","trace[1222722311] 'applied index is now lower than readState.Index' (duration: 42.47362ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:23:39.712573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.733144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:23:39.712605Z","caller":"traceutil/trace.go:171","msg":"trace[694447928] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1216; }","duration":"261.784375ms","start":"2026-03-31T20:23:39.450812Z","end":"2026-03-31T20:23:39.712596Z","steps":["trace[694447928] 'agreement among raft nodes before linearized reading' (duration: 261.712694ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.910208Z","caller":"traceutil/trace.go:171","msg":"trace[2118633693] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"188.032168ms","start":"2026-03-31T20:23:39.722153Z","end":"2026-03-31T20:23:39.910185Z","steps":["trace[2118633693] 'process raft request' (duration: 187.726419ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.910246Z","caller":"traceutil/trace.go:171","msg":"trace[1810234732] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"187.947586ms","start":"2026-03-31T20:23:39.722277Z","end":"2026-03-31T20:23:39.910225Z","steps":["trace[1810234732] 'process raft request' (duration: 187.893724ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.91045Z","caller":"traceutil/trace.go:171","msg":"trace[2061448170] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"188.177752ms","start":"2026-03-31T20:23:39.722244Z","end":"2026-03-31T20:23:39.910422Z","steps":["trace[2061448170] 'process raft request' (duration: 187.878654ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:39.910507Z","caller":"traceutil/trace.go:171","msg":"trace[1384320835] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"188.066019ms","start":"2026-03-31T20:23:39.722234Z","end":"2026-03-31T20:23:39.9103Z","steps":["trace[1384320835] 'process raft request' (duration: 187.820782ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:40.620806Z","caller":"traceutil/trace.go:171","msg":"trace[730631566] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"137.003947ms","start":"2026-03-31T20:23:40.483762Z","end":"2026-03-31T20:23:40.620765Z","steps":["trace[730631566] 'process raft request' (duration: 136.848812ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:40.936266Z","caller":"traceutil/trace.go:171","msg":"trace[573841295] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"157.508737ms","start":"2026-03-31T20:23:40.77872Z","end":"2026-03-31T20:23:40.936229Z","steps":["trace[573841295] 'process raft request' (duration: 157.25357ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:54.059154Z","caller":"traceutil/trace.go:171","msg":"trace[1533668988] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"296.082155ms","start":"2026-03-31T20:23:53.763046Z","end":"2026-03-31T20:23:54.059128Z","steps":["trace[1533668988] 'process raft request' (duration: 287.77304ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:23:54.059297Z","caller":"traceutil/trace.go:171","msg":"trace[546297728] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"153.139484ms","start":"2026-03-31T20:23:53.906132Z","end":"2026-03-31T20:23:54.059272Z","steps":["trace[546297728] 'process raft request' (duration: 152.468117ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:24:20.145698Z","caller":"traceutil/trace.go:171","msg":"trace[1210444744] linearizableReadLoop","detail":"{readStateIndex:1518; appliedIndex:1517; }","duration":"112.906083ms","start":"2026-03-31T20:24:20.032771Z","end":"2026-03-31T20:24:20.145677Z","steps":["trace[1210444744] 'read index received' (duration: 112.77808ms)","trace[1210444744] 'applied index is now lower than readState.Index' (duration: 127.453µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:24:20.145768Z","caller":"traceutil/trace.go:171","msg":"trace[1101210516] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"119.152394ms","start":"2026-03-31T20:24:20.026594Z","end":"2026-03-31T20:24:20.145746Z","steps":["trace[1101210516] 'process raft request' (duration: 118.99073ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:24:20.14584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.053476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-03-31T20:24:20.145863Z","caller":"traceutil/trace.go:171","msg":"trace[2088807516] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1460; }","duration":"113.109367ms","start":"2026-03-31T20:24:20.032748Z","end":"2026-03-31T20:24:20.145857Z","steps":["trace[2088807516] 'agreement among raft nodes before linearized reading' (duration: 113.008305ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:25:20.423555Z","caller":"traceutil/trace.go:171","msg":"trace[594691161] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"117.880388ms","start":"2026-03-31T20:25:20.305638Z","end":"2026-03-31T20:25:20.423518Z","steps":["trace[594691161] 'process raft request' (duration: 89.276718ms)","trace[594691161] 'compare' (duration: 28.327402ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:25:45.925729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.26865ms","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-03-31T20:25:45.925842Z","caller":"traceutil/trace.go:171","msg":"trace[1171746447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1895; }","duration":"261.426644ms","start":"2026-03-31T20:25:45.664388Z","end":"2026-03-31T20:25:45.925815Z","steps":["trace[1171746447] 'range keys from in-memory index tree' (duration: 261.089765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:25:45.925889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.238277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-03-31T20:25:45.925989Z","caller":"traceutil/trace.go:171","msg":"trace[619966509] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1895; }","duration":"276.393861ms","start":"2026-03-31T20:25:45.649571Z","end":"2026-03-31T20:25:45.925964Z","steps":["trace[619966509] 'range keys from in-memory index tree' (duration: 276.055872ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:25:46.064861Z","caller":"traceutil/trace.go:171","msg":"trace[1794106789] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"135.556276ms","start":"2026-03-31T20:25:45.92928Z","end":"2026-03-31T20:25:46.064837Z","steps":["trace[1794106789] 'process raft request' (duration: 135.393632ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:25:46.074167Z","caller":"traceutil/trace.go:171","msg":"trace[204831747] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"141.889062ms","start":"2026-03-31T20:25:45.932245Z","end":"2026-03-31T20:25:46.074134Z","steps":["trace[204831747] 'process raft request' (duration: 141.725277ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:25:46.209732Z","caller":"traceutil/trace.go:171","msg":"trace[326094403] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"128.446332ms","start":"2026-03-31T20:25:46.081255Z","end":"2026-03-31T20:25:46.209701Z","steps":["trace[326094403] 'process raft request' (duration: 128.265218ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:26:57.500462Z","caller":"traceutil/trace.go:171","msg":"trace[1915376497] linearizableReadLoop","detail":"{readStateIndex:2367; appliedIndex:2366; }","duration":"131.690346ms","start":"2026-03-31T20:26:57.368745Z","end":"2026-03-31T20:26:57.500435Z","steps":["trace[1915376497] 'read index received' (duration: 109.224635ms)","trace[1915376497] 'applied index is now lower than readState.Index' (duration: 22.464541ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:26:57.500543Z","caller":"traceutil/trace.go:171","msg":"trace[1772303298] transaction","detail":"{read_only:false; response_revision:2277; number_of_response:1; }","duration":"190.114609ms","start":"2026-03-31T20:26:57.310374Z","end":"2026-03-31T20:26:57.500488Z","steps":["trace[1772303298] 'process raft request' (duration: 167.404161ms)","trace[1772303298] 'compare' (duration: 22.533042ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:26:57.500804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.040177ms","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-03-31T20:26:57.500873Z","caller":"traceutil/trace.go:171","msg":"trace[938277591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2277; }","duration":"132.18251ms","start":"2026-03-31T20:26:57.368675Z","end":"2026-03-31T20:26:57.500858Z","steps":["trace[938277591] 'agreement among raft nodes before linearized reading' (duration: 131.865852ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:26:57.560429Z","caller":"traceutil/trace.go:171","msg":"trace[1372345309] transaction","detail":"{read_only:false; response_revision:2278; number_of_response:1; }","duration":"182.294096ms","start":"2026-03-31T20:26:57.37812Z","end":"2026-03-31T20:26:57.560414Z","steps":["trace[1372345309] 'process raft request' (duration: 182.135272ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:26:57.560526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.827941ms","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-03-31T20:26:57.560597Z","caller":"traceutil/trace.go:171","msg":"trace[598986854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2278; }","duration":"189.912302ms","start":"2026-03-31T20:26:57.370658Z","end":"2026-03-31T20:26:57.56057Z","steps":["trace[598986854] 'agreement among raft nodes before linearized reading' (duration: 189.728378ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:27:05.863508Z","caller":"traceutil/trace.go:171","msg":"trace[120229121] linearizableReadLoop","detail":"{readStateIndex:2418; appliedIndex:2417; }","duration":"142.321342ms","start":"2026-03-31T20:27:05.721161Z","end":"2026-03-31T20:27:05.863483Z","steps":["trace[120229121] 'read index received' (duration: 142.057185ms)","trace[120229121] 'applied index is now lower than readState.Index' (duration: 263.117µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:27:05.863592Z","caller":"traceutil/trace.go:171","msg":"trace[226875902] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"201.511273ms","start":"2026-03-31T20:27:05.662055Z","end":"2026-03-31T20:27:05.863566Z","steps":["trace[226875902] 'process raft request' (duration: 201.243856ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:27:05.863759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.572898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-03-31T20:27:05.863808Z","caller":"traceutil/trace.go:171","msg":"trace[1881874549] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2326; }","duration":"142.696041ms","start":"2026-03-31T20:27:05.721098Z","end":"2026-03-31T20:27:05.863794Z","steps":["trace[1881874549] 'agreement among raft nodes before linearized reading' (duration: 142.499376ms)"],"step_count":1}