{"level":"warn","ts":"2026-06-26T17:00:14.059202Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T17:00:14.059312Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.204.45.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-06-26T17:00:14.059391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T17:00:14.059403Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-26T17:00:14.059425Z","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-06-26T17:00:14.060174Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-26T17:00:14.060262Z","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.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-06-26T17:00:14.064347Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.835427ms"} {"level":"info","ts":"2026-06-26T17:00:14.070785Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-26T17:00:14.070888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T17:00:14.070918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-26T17:00:14.070932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T17:00:14.070961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-26T17:00:14.071003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-26T17:00:14.077838Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T17:00:14.07927Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T17:00:14.082789Z","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-06-26T17:00:14.085719Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T17:00:14.086078Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T17:00:14.086298Z","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-06-26T17:00:14.088199Z","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-06-26T17:00:14.088221Z","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-06-26T17:00:14.091233Z","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-06-26T17:00:14.091422Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T17:00:14.091441Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T17:00:14.091525Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-26T17:00:14.09153Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-26T17:00:14.092631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-26T17:00:14.092732Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-26T17:00:14.172187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T17:00:14.17231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T17:00:14.172344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-26T17:00:14.172376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-26T17:00:14.172394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-26T17:00:14.172418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-26T17:00:14.17244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-26T17:00:14.173419Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T17:00:14.175074Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T17:00:14.175072Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T17:00:14.175107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T17:00:14.175394Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T17:00:14.175458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T17:00:14.17591Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T17:00:14.175996Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T17:00:14.176022Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T17:00:14.17774Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T17:00:14.179136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-26T17:00:19.891243Z","caller":"traceutil/trace.go:171","msg":"trace[2103303476] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"248.52337ms","start":"2026-06-26T17:00:19.642696Z","end":"2026-06-26T17:00:19.891219Z","steps":["trace[2103303476] 'process raft request' (duration: 248.380317ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:19.897826Z","caller":"traceutil/trace.go:171","msg":"trace[543662566] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"184.783068ms","start":"2026-06-26T17:00:19.712977Z","end":"2026-06-26T17:00:19.89776Z","steps":["trace[543662566] 'process raft request' (duration: 184.547762ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:19.897905Z","caller":"traceutil/trace.go:171","msg":"trace[1940035112] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:275; }","duration":"182.605279ms","start":"2026-06-26T17:00:19.715273Z","end":"2026-06-26T17:00:19.897878Z","steps":["trace[1940035112] 'read index received' (duration: 175.752957ms)","trace[1940035112] 'applied index is now lower than readState.Index' (duration: 6.851112ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:00:19.898253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.957088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-26T17:00:19.898354Z","caller":"traceutil/trace.go:171","msg":"trace[76869612] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:272; }","duration":"183.104683ms","start":"2026-06-26T17:00:19.715232Z","end":"2026-06-26T17:00:19.898337Z","steps":["trace[76869612] 'agreement among raft nodes before linearized reading' (duration: 182.820775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:19.900072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.745167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-06-26T17:00:19.900153Z","caller":"traceutil/trace.go:171","msg":"trace[2122665881] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:273; }","duration":"184.86613ms","start":"2026-06-26T17:00:19.715271Z","end":"2026-06-26T17:00:19.900137Z","steps":["trace[2122665881] 'agreement among raft nodes before linearized reading' (duration: 184.711566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:35.270415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.285391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:00:35.270498Z","caller":"traceutil/trace.go:171","msg":"trace[1922669509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"134.407484ms","start":"2026-06-26T17:00:35.136069Z","end":"2026-06-26T17:00:35.270477Z","steps":["trace[1922669509] 'range keys from in-memory index tree' (duration: 134.126916ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:52.526953Z","caller":"traceutil/trace.go:171","msg":"trace[197995530] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"726.627034ms","start":"2026-06-26T17:00:51.8003Z","end":"2026-06-26T17:00:52.526927Z","steps":["trace[197995530] 'process raft request' (duration: 726.507201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.52752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.800281Z","time spent":"726.753326ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.543726Z","caller":"traceutil/trace.go:171","msg":"trace[1627115261] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"740.087207ms","start":"2026-06-26T17:00:51.803613Z","end":"2026-06-26T17:00:52.5437Z","steps":["trace[1627115261] 'process raft request' (duration: 739.885794ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:52.543775Z","caller":"traceutil/trace.go:171","msg":"trace[1435337713] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"729.861955ms","start":"2026-06-26T17:00:51.813878Z","end":"2026-06-26T17:00:52.54374Z","steps":["trace[1435337713] 'process raft request' (duration: 729.736553ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:52.543853Z","caller":"traceutil/trace.go:171","msg":"trace[2005540314] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"727.671981ms","start":"2026-06-26T17:00:51.816146Z","end":"2026-06-26T17:00:52.543818Z","steps":["trace[2005540314] 'process raft request' (duration: 727.510548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.544617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.816139Z","time spent":"728.396336ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T17:00:52.544879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.81386Z","time spent":"730.012549ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.545582Z","caller":"traceutil/trace.go:171","msg":"trace[1399932462] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"703.030233ms","start":"2026-06-26T17:00:51.840896Z","end":"2026-06-26T17:00:52.543926Z","steps":["trace[1399932462] 'process raft request' (duration: 702.900909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.54576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.840885Z","time spent":"704.815828ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.546102Z","caller":"traceutil/trace.go:171","msg":"trace[1851239179] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"712.627103ms","start":"2026-06-26T17:00:51.831244Z","end":"2026-06-26T17:00:52.543871Z","steps":["trace[1851239179] 'process raft request' (duration: 712.452778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.546183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.831227Z","time spent":"714.927798ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T17:00:52.546426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.803592Z","time spent":"740.237821ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.54642Z","caller":"traceutil/trace.go:171","msg":"trace[192753973] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"711.213725ms","start":"2026-06-26T17:00:51.832695Z","end":"2026-06-26T17:00:52.543909Z","steps":["trace[192753973] 'process raft request' (duration: 711.046601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.54662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.832677Z","time spent":"713.870867ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.54685Z","caller":"traceutil/trace.go:171","msg":"trace[197428435] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"685.724298ms","start":"2026-06-26T17:00:51.861111Z","end":"2026-06-26T17:00:52.546835Z","steps":["trace[197428435] 'process raft request' (duration: 682.77081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.546966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.86109Z","time spent":"685.842331ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.54705Z","caller":"traceutil/trace.go:171","msg":"trace[1713009065] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"699.190156ms","start":"2026-06-26T17:00:51.844812Z","end":"2026-06-26T17:00:52.544002Z","steps":["trace[1713009065] 'process raft request' (duration: 699.028592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.547489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.844804Z","time spent":"702.564502ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.547737Z","caller":"traceutil/trace.go:171","msg":"trace[691509385] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"686.455372ms","start":"2026-06-26T17:00:51.861266Z","end":"2026-06-26T17:00:52.547721Z","steps":["trace[691509385] 'process raft request' (duration: 684.661217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.547837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.861244Z","time spent":"686.563784ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.549299Z","caller":"traceutil/trace.go:171","msg":"trace[953974795] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"676.378792ms","start":"2026-06-26T17:00:51.872874Z","end":"2026-06-26T17:00:52.549253Z","steps":["trace[953974795] 'process raft request' (duration: 674.995695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.549428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.872812Z","time spent":"676.567015ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:52.556416Z","caller":"traceutil/trace.go:171","msg":"trace[1234227081] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:546; }","duration":"421.492788ms","start":"2026-06-26T17:00:52.134898Z","end":"2026-06-26T17:00:52.556391Z","steps":["trace[1234227081] 'read index received' (duration: 392.030727ms)","trace[1234227081] 'applied index is now lower than readState.Index' (duration: 29.461411ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:00:52.556462Z","caller":"traceutil/trace.go:171","msg":"trace[1030567585] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"588.902332ms","start":"2026-06-26T17:00:51.967554Z","end":"2026-06-26T17:00:52.556456Z","steps":["trace[1030567585] 'process raft request' (duration: 581.970496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.556497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:51.967528Z","time spent":"588.945654ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T17:00:52.556577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.675102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:00:52.556595Z","caller":"traceutil/trace.go:171","msg":"trace[1992782858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"421.715172ms","start":"2026-06-26T17:00:52.134873Z","end":"2026-06-26T17:00:52.556588Z","steps":["trace[1992782858] 'agreement among raft nodes before linearized reading' (duration: 421.667661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.556609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:52.134857Z","time spent":"421.749044ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T17:00:52.576525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.90205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-26T17:00:52.576525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.35387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T17:00:52.5766Z","caller":"traceutil/trace.go:171","msg":"trace[167761320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"199.023553ms","start":"2026-06-26T17:00:52.377559Z","end":"2026-06-26T17:00:52.576583Z","steps":["trace[167761320] 'agreement among raft nodes before linearized reading' (duration: 198.88758ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:52.576659Z","caller":"traceutil/trace.go:171","msg":"trace[1537271320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:546; }","duration":"234.485782ms","start":"2026-06-26T17:00:52.342117Z","end":"2026-06-26T17:00:52.576603Z","steps":["trace[1537271320] 'agreement among raft nodes before linearized reading' (duration: 234.337599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:52.576847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.997772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T17:00:52.576872Z","caller":"traceutil/trace.go:171","msg":"trace[2032069524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"236.059153ms","start":"2026-06-26T17:00:52.340807Z","end":"2026-06-26T17:00:52.576867Z","steps":["trace[2032069524] 'agreement among raft nodes before linearized reading' (duration: 236.012412ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:53.298256Z","caller":"traceutil/trace.go:171","msg":"trace[781971525] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"381.168956ms","start":"2026-06-26T17:00:52.917055Z","end":"2026-06-26T17:00:53.298224Z","steps":["trace[781971525] 'process raft request' (duration: 364.737816ms)","trace[781971525] 'compare' (duration: 15.918511ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:00:53.298484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:52.917027Z","time spent":"381.394961ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:00:53.300432Z","caller":"traceutil/trace.go:171","msg":"trace[932098249] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"375.296201ms","start":"2026-06-26T17:00:52.925119Z","end":"2026-06-26T17:00:53.300415Z","steps":["trace[932098249] 'process raft request' (duration: 375.062236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:53.300758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:52.925093Z","time spent":"375.379782ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:00:53.307739Z","caller":"traceutil/trace.go:171","msg":"trace[1466851651] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:605; }","duration":"172.266788ms","start":"2026-06-26T17:00:53.135462Z","end":"2026-06-26T17:00:53.307729Z","steps":["trace[1466851651] 'read index received' (duration: 146.390723ms)","trace[1466851651] 'applied index is now lower than readState.Index' (duration: 25.875315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:00:53.307793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.33633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:00:53.307819Z","caller":"traceutil/trace.go:171","msg":"trace[2090545147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"172.401301ms","start":"2026-06-26T17:00:53.13541Z","end":"2026-06-26T17:00:53.307812Z","steps":["trace[2090545147] 'agreement among raft nodes before linearized reading' (duration: 172.35926ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:58.521041Z","caller":"traceutil/trace.go:171","msg":"trace[1048664573] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"207.602304ms","start":"2026-06-26T17:00:58.313409Z","end":"2026-06-26T17:00:58.521011Z","steps":["trace[1048664573] 'process raft request' (duration: 206.971302ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:00:59.100216Z","caller":"traceutil/trace.go:171","msg":"trace[171586358] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"223.810165ms","start":"2026-06-26T17:00:58.87638Z","end":"2026-06-26T17:00:59.10019Z","steps":["trace[171586358] 'process raft request' (duration: 223.670773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:00:59.63594Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496992398802029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T17:01:00.055857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.263715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:00.055957Z","caller":"traceutil/trace.go:171","msg":"trace[1256647419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"920.357797ms","start":"2026-06-26T17:00:59.135568Z","end":"2026-06-26T17:01:00.055926Z","steps":["trace[1256647419] 'agreement among raft nodes before linearized reading' (duration: 920.036991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:00.055999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:59.135499Z","time spent":"920.490779ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T17:01:00.056284Z","caller":"traceutil/trace.go:171","msg":"trace[1231203173] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"919.97163ms","start":"2026-06-26T17:00:59.135585Z","end":"2026-06-26T17:01:00.055557Z","steps":["trace[1231203173] 'read index received' (duration: 918.711917ms)","trace[1231203173] 'applied index is now lower than readState.Index' (duration: 1.257983ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:00.05646Z","caller":"traceutil/trace.go:171","msg":"trace[376515287] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.042872073s","start":"2026-06-26T17:00:59.01353Z","end":"2026-06-26T17:01:00.056402Z","steps":["trace[376515287] 'process raft request' (duration: 1.040985778s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:00.056735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:00:59.013505Z","time spent":"1.043055086s","remote":"127.0.0.1:55124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:00.279484Z","caller":"traceutil/trace.go:171","msg":"trace[1091930413] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"167.838228ms","start":"2026-06-26T17:01:00.111611Z","end":"2026-06-26T17:01:00.27945Z","steps":["trace[1091930413] 'process raft request' (duration: 101.762614ms)","trace[1091930413] 'compare' (duration: 65.919931ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:01.128904Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496992398802035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T17:01:01.629051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496992398802035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T17:01:02.129525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496992398802035,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T17:01:02.48009Z","caller":"traceutil/trace.go:171","msg":"trace[164559521] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.901802426s","start":"2026-06-26T17:01:00.578236Z","end":"2026-06-26T17:01:02.480038Z","steps":["trace[164559521] 'process raft request' (duration: 1.886761911s)","trace[164559521] 'compare' (duration: 14.210729ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:02.480314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.578206Z","time spent":"1.901996129s","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:02.485269Z","caller":"traceutil/trace.go:171","msg":"trace[1251486218] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"1.856939423s","start":"2026-06-26T17:01:00.628306Z","end":"2026-06-26T17:01:02.485246Z","steps":["trace[1251486218] 'read index received' (duration: 1.836655883s)","trace[1251486218] 'applied index is now lower than readState.Index' (duration: 20.28264ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:02.485373Z","caller":"traceutil/trace.go:171","msg":"trace[16327688] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.804858189s","start":"2026-06-26T17:01:00.680506Z","end":"2026-06-26T17:01:02.485364Z","steps":["trace[16327688] 'process raft request' (duration: 1.803979673s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.485486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.680481Z","time spent":"1.80491814s","remote":"127.0.0.1:55124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:02.48572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.857424081s","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-06-26T17:01:02.485748Z","caller":"traceutil/trace.go:171","msg":"trace[198406376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"1.857509034s","start":"2026-06-26T17:01:00.628232Z","end":"2026-06-26T17:01:02.485742Z","steps":["trace[198406376] 'agreement among raft nodes before linearized reading' (duration: 1.857414572s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.485768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.6282Z","time spent":"1.857564015s","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T17:01:02.486018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.851848248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T17:01:02.486075Z","caller":"traceutil/trace.go:171","msg":"trace[1285544061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.85196744s","start":"2026-06-26T17:01:00.634093Z","end":"2026-06-26T17:01:02.48606Z","steps":["trace[1285544061] 'agreement among raft nodes before linearized reading' (duration: 1.851802458s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.486108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.634067Z","time spent":"1.852035672s","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T17:01:02.486128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.790500512s","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-06-26T17:01:02.48616Z","caller":"traceutil/trace.go:171","msg":"trace[85154422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"1.790567913s","start":"2026-06-26T17:01:00.695585Z","end":"2026-06-26T17:01:02.486152Z","steps":["trace[85154422] 'agreement among raft nodes before linearized reading' (duration: 1.790491302s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.486205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.695568Z","time spent":"1.790610325s","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T17:01:02.486285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.833078092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T17:01:02.486311Z","caller":"traceutil/trace.go:171","msg":"trace[1352780151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.833132033s","start":"2026-06-26T17:01:00.653173Z","end":"2026-06-26T17:01:02.486305Z","steps":["trace[1352780151] 'agreement among raft nodes before linearized reading' (duration: 1.833062171s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.486331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:00.653158Z","time spent":"1.833169264s","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T17:01:02.486356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.352229913s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:02.486409Z","caller":"traceutil/trace.go:171","msg":"trace[1987059373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"1.352318874s","start":"2026-06-26T17:01:01.134083Z","end":"2026-06-26T17:01:02.486402Z","steps":["trace[1987059373] 'agreement among raft nodes before linearized reading' (duration: 1.352254863s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:02.486467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:01.134062Z","time spent":"1.352399735s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T17:01:04.456457Z","caller":"traceutil/trace.go:171","msg":"trace[417786606] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"436.268174ms","start":"2026-06-26T17:01:04.020148Z","end":"2026-06-26T17:01:04.456416Z","steps":["trace[417786606] 'process raft request' (duration: 436.028229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:04.456864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:04.020127Z","time spent":"436.61413ms","remote":"127.0.0.1:55082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T17:01:04.456925Z","caller":"traceutil/trace.go:171","msg":"trace[1740892537] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:699; }","duration":"321.394589ms","start":"2026-06-26T17:01:04.135487Z","end":"2026-06-26T17:01:04.456882Z","steps":["trace[1740892537] 'read index received' (duration: 321.381109ms)","trace[1740892537] 'applied index is now lower than readState.Index' (duration: 11.27µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:04.45709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.581222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:04.457159Z","caller":"traceutil/trace.go:171","msg":"trace[1502811192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:674; }","duration":"321.704044ms","start":"2026-06-26T17:01:04.135438Z","end":"2026-06-26T17:01:04.457142Z","steps":["trace[1502811192] 'agreement among raft nodes before linearized reading' (duration: 321.548852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:04.457197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:04.135422Z","time spent":"321.766985ms","remote":"127.0.0.1:55056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T17:01:04.484313Z","caller":"traceutil/trace.go:171","msg":"trace[1296156228] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"264.236001ms","start":"2026-06-26T17:01:04.220046Z","end":"2026-06-26T17:01:04.484282Z","steps":["trace[1296156228] 'process raft request' (duration: 264.033986ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:14.149582Z","caller":"traceutil/trace.go:171","msg":"trace[1254929368] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"187.176784ms","start":"2026-06-26T17:01:13.962376Z","end":"2026-06-26T17:01:14.149553Z","steps":["trace[1254929368] 'process raft request' (duration: 169.523638ms)","trace[1254929368] 'compare' (duration: 17.35374ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:14.708917Z","caller":"traceutil/trace.go:171","msg":"trace[1098854611] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"148.302196ms","start":"2026-06-26T17:01:14.560576Z","end":"2026-06-26T17:01:14.708878Z","steps":["trace[1098854611] 'read index received' (duration: 147.94311ms)","trace[1098854611] 'applied index is now lower than readState.Index' (duration: 357.576µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:14.709092Z","caller":"traceutil/trace.go:171","msg":"trace[2008847073] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"149.416575ms","start":"2026-06-26T17:01:14.559611Z","end":"2026-06-26T17:01:14.709028Z","steps":["trace[2008847073] 'process raft request' (duration: 149.004688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:14.709546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.970968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T17:01:14.709645Z","caller":"traceutil/trace.go:171","msg":"trace[1192575105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"149.11808ms","start":"2026-06-26T17:01:14.560507Z","end":"2026-06-26T17:01:14.709626Z","steps":["trace[1192575105] 'agreement among raft nodes before linearized reading' (duration: 148.780054ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:14.897426Z","caller":"traceutil/trace.go:171","msg":"trace[798771821] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"188.267349ms","start":"2026-06-26T17:01:14.709127Z","end":"2026-06-26T17:01:14.897394Z","steps":["trace[798771821] 'read index received' (duration: 91.617647ms)","trace[798771821] 'applied index is now lower than readState.Index' (duration: 96.648242ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:14.897453Z","caller":"traceutil/trace.go:171","msg":"trace[1514767892] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"335.197422ms","start":"2026-06-26T17:01:14.562234Z","end":"2026-06-26T17:01:14.897432Z","steps":["trace[1514767892] 'process raft request' (duration: 238.49754ms)","trace[1514767892] 'compare' (duration: 96.54144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:14.89762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:14.562212Z","time spent":"335.312734ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:14.89789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.601869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T17:01:14.897941Z","caller":"traceutil/trace.go:171","msg":"trace[973249691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"335.74632ms","start":"2026-06-26T17:01:14.562187Z","end":"2026-06-26T17:01:14.897933Z","steps":["trace[973249691] 'agreement among raft nodes before linearized reading' (duration: 335.390215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:14.898166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:14.562169Z","time spent":"335.979845ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T17:01:15.289007Z","caller":"traceutil/trace.go:171","msg":"trace[377600656] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:811; }","duration":"329.913559ms","start":"2026-06-26T17:01:14.95906Z","end":"2026-06-26T17:01:15.288973Z","steps":["trace[377600656] 'read index received' (duration: 277.341054ms)","trace[377600656] 'applied index is now lower than readState.Index' (duration: 52.571465ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:15.289088Z","caller":"traceutil/trace.go:171","msg":"trace[762223596] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"385.493743ms","start":"2026-06-26T17:01:14.903543Z","end":"2026-06-26T17:01:15.289037Z","steps":["trace[762223596] 'process raft request' (duration: 385.314229ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:15.289051Z","caller":"traceutil/trace.go:171","msg":"trace[1857869756] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"572.750553ms","start":"2026-06-26T17:01:14.716249Z","end":"2026-06-26T17:01:15.288999Z","steps":["trace[1857869756] 'process raft request' (duration: 520.046156ms)","trace[1857869756] 'compare' (duration: 52.165848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:15.289288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.211065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-rz8sc\" ","response":"range_response_count:1 size:5047"} {"level":"info","ts":"2026-06-26T17:01:15.28934Z","caller":"traceutil/trace.go:171","msg":"trace[1062007923] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-rz8sc; range_end:; response_count:1; response_revision:785; }","duration":"330.287026ms","start":"2026-06-26T17:01:14.959038Z","end":"2026-06-26T17:01:15.289325Z","steps":["trace[1062007923] 'agreement among raft nodes before linearized reading' (duration: 330.101363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:15.289332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:14.903518Z","time spent":"385.679815ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:15.289394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.243332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T17:01:15.289271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.105889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T17:01:15.289454Z","caller":"traceutil/trace.go:171","msg":"trace[1763147737] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:785; }","duration":"219.370893ms","start":"2026-06-26T17:01:15.070074Z","end":"2026-06-26T17:01:15.289445Z","steps":["trace[1763147737] 'agreement among raft nodes before linearized reading' (duration: 219.110239ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:15.289473Z","caller":"traceutil/trace.go:171","msg":"trace[1017812676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"153.342164ms","start":"2026-06-26T17:01:15.136104Z","end":"2026-06-26T17:01:15.289446Z","steps":["trace[1017812676] 'agreement among raft nodes before linearized reading' (duration: 153.267203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:15.289395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:14.958907Z","time spent":"330.478199ms","remote":"127.0.0.1:55226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5070,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-rz8sc\" "} {"level":"warn","ts":"2026-06-26T17:01:15.289948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:14.716219Z","time spent":"573.098209ms","remote":"127.0.0.1:55288","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-06-26T17:01:15.686986Z","caller":"traceutil/trace.go:171","msg":"trace[539967075] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"384.253661ms","start":"2026-06-26T17:01:15.302706Z","end":"2026-06-26T17:01:15.68696Z","steps":["trace[539967075] 'process raft request' (duration: 384.086108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:15.687257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:15.302685Z","time spent":"384.453605ms","remote":"127.0.0.1:55226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4854,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:16.066695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.108403ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T17:01:16.066894Z","caller":"traceutil/trace.go:171","msg":"trace[865638755] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"373.936212ms","start":"2026-06-26T17:01:15.692926Z","end":"2026-06-26T17:01:16.066862Z","steps":["trace[865638755] 'process raft request' (duration: 154.102647ms)","trace[865638755] 'compare' (duration: 218.627075ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:16.067573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:15.692902Z","time spent":"374.48522ms","remote":"127.0.0.1:55208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:16.073483Z","caller":"traceutil/trace.go:171","msg":"trace[1362736048] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"377.897906ms","start":"2026-06-26T17:01:15.69552Z","end":"2026-06-26T17:01:16.073418Z","steps":["trace[1362736048] 'process raft request' (duration: 377.706543ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:16.073575Z","caller":"traceutil/trace.go:171","msg":"trace[352811107] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"376.539494ms","start":"2026-06-26T17:01:15.696997Z","end":"2026-06-26T17:01:16.073537Z","steps":["trace[352811107] 'process raft request' (duration: 376.358131ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:16.073683Z","caller":"traceutil/trace.go:171","msg":"trace[1517576916] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:815; }","duration":"193.214211ms","start":"2026-06-26T17:01:15.880445Z","end":"2026-06-26T17:01:16.07366Z","steps":["trace[1517576916] 'read index received' (duration: 192.813655ms)","trace[1517576916] 'applied index is now lower than readState.Index' (duration: 397.976µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:16.073759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:15.69698Z","time spent":"376.667046ms","remote":"127.0.0.1:55546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:16.073869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:15.695485Z","time spent":"378.11923ms","remote":"127.0.0.1:55292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:16.073906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.452365ms","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-06-26T17:01:16.074138Z","caller":"traceutil/trace.go:171","msg":"trace[869448249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:789; }","duration":"193.688909ms","start":"2026-06-26T17:01:15.880385Z","end":"2026-06-26T17:01:16.074074Z","steps":["trace[869448249] 'agreement among raft nodes before linearized reading' (duration: 193.375274ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:16.837812Z","caller":"traceutil/trace.go:171","msg":"trace[485579897] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"117.941153ms","start":"2026-06-26T17:01:16.719828Z","end":"2026-06-26T17:01:16.837769Z","steps":["trace[485579897] 'process raft request' (duration: 117.78714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:20.596308Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496992398802370,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T17:01:21.092245Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.100622622s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T17:01:21.092798Z","caller":"traceutil/trace.go:171","msg":"trace[1848496662] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:841; }","duration":"997.379807ms","start":"2026-06-26T17:01:20.095391Z","end":"2026-06-26T17:01:21.09277Z","steps":["trace[1848496662] 'read index received' (duration: 997.170264ms)","trace[1848496662] 'applied index is now lower than readState.Index' (duration: 208.133µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:21.092916Z","caller":"traceutil/trace.go:171","msg":"trace[1171088514] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"1.101427765s","start":"2026-06-26T17:01:19.991477Z","end":"2026-06-26T17:01:21.092905Z","steps":["trace[1171088514] 'process raft request' (duration: 1.10110334s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:21.09305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:19.991442Z","time spent":"1.101521247s","remote":"127.0.0.1:55276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:21.093184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.775053ms","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-06-26T17:01:21.093265Z","caller":"traceutil/trace.go:171","msg":"trace[1918041954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:812; }","duration":"997.904745ms","start":"2026-06-26T17:01:20.095341Z","end":"2026-06-26T17:01:21.093246Z","steps":["trace[1918041954] 'agreement among raft nodes before linearized reading' (duration: 997.710452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:21.093306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:20.095316Z","time spent":"997.982096ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T17:01:21.102728Z","caller":"traceutil/trace.go:171","msg":"trace[250163816] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"198.153486ms","start":"2026-06-26T17:01:20.904543Z","end":"2026-06-26T17:01:21.102697Z","steps":["trace[250163816] 'process raft request' (duration: 197.910622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:21.102791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.554864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:21.102891Z","caller":"traceutil/trace.go:171","msg":"trace[2087493625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"967.739467ms","start":"2026-06-26T17:01:20.13513Z","end":"2026-06-26T17:01:21.10287Z","steps":["trace[2087493625] 'agreement among raft nodes before linearized reading' (duration: 967.544164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:21.102944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:20.135096Z","time spent":"967.838059ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T17:01:21.102981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.374239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-26T17:01:21.103102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.343881ms","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-06-26T17:01:21.103181Z","caller":"traceutil/trace.go:171","msg":"trace[1150839393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:813; }","duration":"249.444143ms","start":"2026-06-26T17:01:20.853711Z","end":"2026-06-26T17:01:21.103155Z","steps":["trace[1150839393] 'agreement among raft nodes before linearized reading' (duration: 249.24008ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:21.103043Z","caller":"traceutil/trace.go:171","msg":"trace[399023036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:813; }","duration":"180.482361ms","start":"2026-06-26T17:01:20.922542Z","end":"2026-06-26T17:01:21.103024Z","steps":["trace[399023036] 'agreement among raft nodes before linearized reading' (duration: 180.227477ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:25.194374Z","caller":"traceutil/trace.go:171","msg":"trace[115134132] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"175.267991ms","start":"2026-06-26T17:01:25.019057Z","end":"2026-06-26T17:01:25.194325Z","steps":["trace[115134132] 'process raft request' (duration: 174.995037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:25.572616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.751954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T17:01:25.572791Z","caller":"traceutil/trace.go:171","msg":"trace[268297148] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"372.903372ms","start":"2026-06-26T17:01:25.199862Z","end":"2026-06-26T17:01:25.572765Z","steps":["trace[268297148] 'process raft request' (duration: 243.860913ms)","trace[268297148] 'compare' (duration: 128.47385ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:25.572901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.199841Z","time spent":"372.997873ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:25.661475Z","caller":"traceutil/trace.go:171","msg":"trace[1887237397] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"460.910398ms","start":"2026-06-26T17:01:25.200539Z","end":"2026-06-26T17:01:25.661449Z","steps":["trace[1887237397] 'process raft request' (duration: 460.652174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:25.661635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.200523Z","time spent":"461.026391ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:25.661797Z","caller":"traceutil/trace.go:171","msg":"trace[754474915] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"460.928558ms","start":"2026-06-26T17:01:25.200839Z","end":"2026-06-26T17:01:25.661768Z","steps":["trace[754474915] 'process raft request' (duration: 460.495041ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:25.661903Z","caller":"traceutil/trace.go:171","msg":"trace[1290382696] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:860; }","duration":"327.035465ms","start":"2026-06-26T17:01:25.334849Z","end":"2026-06-26T17:01:25.661884Z","steps":["trace[1290382696] 'read index received' (duration: 108.886843ms)","trace[1290382696] 'applied index is now lower than readState.Index' (duration: 218.147052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:25.661943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.200801Z","time spent":"461.06755ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T17:01:25.662006Z","caller":"traceutil/trace.go:171","msg":"trace[1483787557] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"457.381563ms","start":"2026-06-26T17:01:25.204615Z","end":"2026-06-26T17:01:25.661997Z","steps":["trace[1483787557] 'process raft request' (duration: 456.974897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:25.662073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.2046Z","time spent":"457.436184ms","remote":"127.0.0.1:55226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:25.662219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.939947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-26T17:01:25.662284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.4437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T17:01:25.662298Z","caller":"traceutil/trace.go:171","msg":"trace[836747841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:833; }","duration":"326.026948ms","start":"2026-06-26T17:01:25.336234Z","end":"2026-06-26T17:01:25.662261Z","steps":["trace[836747841] 'agreement among raft nodes before linearized reading' (duration: 325.803815ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:25.662329Z","caller":"traceutil/trace.go:171","msg":"trace[2011449275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:833; }","duration":"327.513592ms","start":"2026-06-26T17:01:25.334799Z","end":"2026-06-26T17:01:25.662312Z","steps":["trace[2011449275] 'agreement among raft nodes before linearized reading' (duration: 327.364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:25.66236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.334775Z","time spent":"327.578513ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T17:01:25.662346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:25.336226Z","time spent":"326.106349ms","remote":"127.0.0.1:55288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T17:01:25.923939Z","caller":"traceutil/trace.go:171","msg":"trace[314598607] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:867; }","duration":"166.831429ms","start":"2026-06-26T17:01:25.757078Z","end":"2026-06-26T17:01:25.92391Z","steps":["trace[314598607] 'read index received' (duration: 163.762001ms)","trace[314598607] 'applied index is now lower than readState.Index' (duration: 3.068218ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:25.92427Z","caller":"traceutil/trace.go:171","msg":"trace[280464818] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"169.275427ms","start":"2026-06-26T17:01:25.754707Z","end":"2026-06-26T17:01:25.923983Z","steps":["trace[280464818] 'process raft request' (duration: 166.199739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:25.92435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.242115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/envoy-gateway-system/\" range_end:\"/registry/resourcequotas/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:25.924504Z","caller":"traceutil/trace.go:171","msg":"trace[1252089736] range","detail":"{range_begin:/registry/resourcequotas/envoy-gateway-system/; range_end:/registry/resourcequotas/envoy-gateway-system0; response_count:0; response_revision:837; }","duration":"167.4741ms","start":"2026-06-26T17:01:25.757004Z","end":"2026-06-26T17:01:25.924478Z","steps":["trace[1252089736] 'agreement among raft nodes before linearized reading' (duration: 167.011362ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:26.119529Z","caller":"traceutil/trace.go:171","msg":"trace[1111867464] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"125.615634ms","start":"2026-06-26T17:01:25.99387Z","end":"2026-06-26T17:01:26.119485Z","steps":["trace[1111867464] 'process raft request' (duration: 108.246994ms)","trace[1111867464] 'compare' (duration: 17.084476ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:26.742209Z","caller":"traceutil/trace.go:171","msg":"trace[274714380] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"604.227484ms","start":"2026-06-26T17:01:26.137926Z","end":"2026-06-26T17:01:26.742154Z","steps":["trace[274714380] 'process raft request' (duration: 596.542774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:26.742446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:26.137903Z","time spent":"604.435857ms","remote":"127.0.0.1:55354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1116,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T17:01:27.881926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.513206ms","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-06-26T17:01:27.882013Z","caller":"traceutil/trace.go:171","msg":"trace[1738435963] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:866; }","duration":"214.673618ms","start":"2026-06-26T17:01:27.66732Z","end":"2026-06-26T17:01:27.881993Z","steps":["trace[1738435963] 'range keys from in-memory index tree' (duration: 214.347463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:27.882006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.934498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-26T17:01:27.882012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.559035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T17:01:27.882077Z","caller":"traceutil/trace.go:171","msg":"trace[1300606565] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:866; }","duration":"146.698927ms","start":"2026-06-26T17:01:27.735362Z","end":"2026-06-26T17:01:27.882061Z","steps":["trace[1300606565] 'range keys from in-memory index tree' (duration: 146.393602ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:27.882081Z","caller":"traceutil/trace.go:171","msg":"trace[272777425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:866; }","duration":"128.025109ms","start":"2026-06-26T17:01:27.754025Z","end":"2026-06-26T17:01:27.882051Z","steps":["trace[272777425] 'range keys from in-memory index tree' (duration: 127.811235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:27.882202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.889177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T17:01:27.88222Z","caller":"traceutil/trace.go:171","msg":"trace[1193929640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:866; }","duration":"127.916637ms","start":"2026-06-26T17:01:27.754298Z","end":"2026-06-26T17:01:27.882215Z","steps":["trace[1193929640] 'range keys from in-memory index tree' (duration: 127.828876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:27.882395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.606672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-26T17:01:27.882428Z","caller":"traceutil/trace.go:171","msg":"trace[486156237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:866; }","duration":"215.673323ms","start":"2026-06-26T17:01:27.666745Z","end":"2026-06-26T17:01:27.882418Z","steps":["trace[486156237] 'range keys from in-memory index tree' (duration: 215.5005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:28.146732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.216953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T17:01:28.146975Z","caller":"traceutil/trace.go:171","msg":"trace[311729923] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"253.8922ms","start":"2026-06-26T17:01:27.89306Z","end":"2026-06-26T17:01:28.146952Z","steps":["trace[311729923] 'process raft request' (duration: 132.352213ms)","trace[311729923] 'compare' (duration: 121.05802ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:28.442185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.182269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T17:01:28.442866Z","caller":"traceutil/trace.go:171","msg":"trace[276082565] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:873; }","duration":"155.148084ms","start":"2026-06-26T17:01:28.287692Z","end":"2026-06-26T17:01:28.44284Z","steps":["trace[276082565] 'count revisions from in-memory index tree' (duration: 154.094628ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:29.555497Z","caller":"traceutil/trace.go:171","msg":"trace[1292548795] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"146.378777ms","start":"2026-06-26T17:01:29.40909Z","end":"2026-06-26T17:01:29.555469Z","steps":["trace[1292548795] 'process raft request' (duration: 146.192974ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:29.556518Z","caller":"traceutil/trace.go:171","msg":"trace[2017388648] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:909; }","duration":"140.835682ms","start":"2026-06-26T17:01:29.415661Z","end":"2026-06-26T17:01:29.556496Z","steps":["trace[2017388648] 'read index received' (duration: 139.578282ms)","trace[2017388648] 'applied index is now lower than readState.Index' (duration: 1.25667ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:01:29.556565Z","caller":"traceutil/trace.go:171","msg":"trace[890945746] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"146.66104ms","start":"2026-06-26T17:01:29.409872Z","end":"2026-06-26T17:01:29.556533Z","steps":["trace[890945746] 'process raft request' (duration: 146.524978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:29.556772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.086545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-06-26T17:01:29.556805Z","caller":"traceutil/trace.go:171","msg":"trace[558205456] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:879; }","duration":"141.167057ms","start":"2026-06-26T17:01:29.415629Z","end":"2026-06-26T17:01:29.556796Z","steps":["trace[558205456] 'agreement among raft nodes before linearized reading' (duration: 140.953094ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:38.459618Z","caller":"traceutil/trace.go:171","msg":"trace[1001905144] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"375.70738ms","start":"2026-06-26T17:01:38.08389Z","end":"2026-06-26T17:01:38.459598Z","steps":["trace[1001905144] 'read index received' (duration: 276.268325ms)","trace[1001905144] 'applied index is now lower than readState.Index' (duration: 99.438155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:38.459778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.093741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:01:38.459804Z","caller":"traceutil/trace.go:171","msg":"trace[2127380134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"324.152642ms","start":"2026-06-26T17:01:38.135642Z","end":"2026-06-26T17:01:38.459795Z","steps":["trace[2127380134] 'agreement among raft nodes before linearized reading' (duration: 324.07188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:38.459829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:38.13563Z","time spent":"324.191292ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T17:01:38.459765Z","caller":"traceutil/trace.go:171","msg":"trace[905951397] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"376.663534ms","start":"2026-06-26T17:01:38.083024Z","end":"2026-06-26T17:01:38.459688Z","steps":["trace[905951397] 'process raft request' (duration: 277.208769ms)","trace[905951397] 'compare' (duration: 99.249692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T17:01:38.459989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.067256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-rz8sc\" ","response":"range_response_count:1 size:5069"} {"level":"info","ts":"2026-06-26T17:01:38.460084Z","caller":"traceutil/trace.go:171","msg":"trace[586476197] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-rz8sc; range_end:; response_count:1; response_revision:991; }","duration":"376.188348ms","start":"2026-06-26T17:01:38.083875Z","end":"2026-06-26T17:01:38.460063Z","steps":["trace[586476197] 'agreement among raft nodes before linearized reading' (duration: 375.831032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:01:38.460096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:38.083014Z","time spent":"376.886618ms","remote":"127.0.0.1:55546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T17:01:38.46014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T17:01:38.083866Z","time spent":"376.256958ms","remote":"127.0.0.1:55226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5092,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-rz8sc\" "} {"level":"info","ts":"2026-06-26T17:01:38.63817Z","caller":"traceutil/trace.go:171","msg":"trace[1357925832] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"171.703885ms","start":"2026-06-26T17:01:38.466438Z","end":"2026-06-26T17:01:38.638142Z","steps":["trace[1357925832] 'process raft request' (duration: 171.450402ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:38.638436Z","caller":"traceutil/trace.go:171","msg":"trace[142485799] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"138.225629ms","start":"2026-06-26T17:01:38.500163Z","end":"2026-06-26T17:01:38.638388Z","steps":["trace[142485799] 'process raft request' (duration: 137.914164ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:01:38.661119Z","caller":"traceutil/trace.go:171","msg":"trace[319116367] transaction","detail":"{read_only:false; number_of_response:1; response_revision:994; }","duration":"112.658186ms","start":"2026-06-26T17:01:38.54843Z","end":"2026-06-26T17:01:38.661088Z","steps":["trace[319116367] 'process raft request' (duration: 112.436383ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:02:09.931379Z","caller":"traceutil/trace.go:171","msg":"trace[1502851798] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"176.976459ms","start":"2026-06-26T17:02:09.75438Z","end":"2026-06-26T17:02:09.931356Z","steps":["trace[1502851798] 'process raft request' (duration: 175.925266ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:02:22.34953Z","caller":"traceutil/trace.go:171","msg":"trace[1287116255] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"111.319618ms","start":"2026-06-26T17:02:22.238178Z","end":"2026-06-26T17:02:22.349497Z","steps":["trace[1287116255] 'process raft request' (duration: 111.119344ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:02:22.581689Z","caller":"traceutil/trace.go:171","msg":"trace[446672767] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1188; }","duration":"215.905632ms","start":"2026-06-26T17:02:22.365759Z","end":"2026-06-26T17:02:22.581665Z","steps":["trace[446672767] 'read index received' (duration: 215.705719ms)","trace[446672767] 'applied index is now lower than readState.Index' (duration: 198.823µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T17:02:22.581734Z","caller":"traceutil/trace.go:171","msg":"trace[1488507143] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"225.507278ms","start":"2026-06-26T17:02:22.3562Z","end":"2026-06-26T17:02:22.581707Z","steps":["trace[1488507143] 'process raft request' (duration: 225.320046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:02:22.582166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.596064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T17:02:22.582227Z","caller":"traceutil/trace.go:171","msg":"trace[351726739] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1146; }","duration":"203.679335ms","start":"2026-06-26T17:02:22.378528Z","end":"2026-06-26T17:02:22.582208Z","steps":["trace[351726739] 'agreement among raft nodes before linearized reading' (duration: 203.595724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:02:22.581943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.163815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-26T17:02:22.582374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.105685ms","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-06-26T17:02:22.58246Z","caller":"traceutil/trace.go:171","msg":"trace[1688003276] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1146; }","duration":"140.252136ms","start":"2026-06-26T17:02:22.44219Z","end":"2026-06-26T17:02:22.582442Z","steps":["trace[1688003276] 'agreement among raft nodes before linearized reading' (duration: 139.991904ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:02:22.582421Z","caller":"traceutil/trace.go:171","msg":"trace[1048490081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1146; }","duration":"216.667672ms","start":"2026-06-26T17:02:22.365729Z","end":"2026-06-26T17:02:22.582397Z","steps":["trace[1048490081] 'agreement among raft nodes before linearized reading' (duration: 216.074584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T17:02:24.628864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.966658ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T17:02:24.629029Z","caller":"traceutil/trace.go:171","msg":"trace[1940199172] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1152; }","duration":"108.12725ms","start":"2026-06-26T17:02:24.520861Z","end":"2026-06-26T17:02:24.628989Z","steps":["trace[1940199172] 'range keys from in-memory index tree' (duration: 107.947277ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:02:26.28226Z","caller":"traceutil/trace.go:171","msg":"trace[508538252] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"114.093553ms","start":"2026-06-26T17:02:26.168142Z","end":"2026-06-26T17:02:26.282236Z","steps":["trace[508538252] 'process raft request' (duration: 113.950221ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T17:03:16.759684Z","caller":"traceutil/trace.go:171","msg":"trace[307579765] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"296.681576ms","start":"2026-06-26T17:03:16.462969Z","end":"2026-06-26T17:03:16.759651Z","steps":["trace[307579765] 'process raft request' (duration: 296.442793ms)"],"step_count":1}