{"level":"warn","ts":"2026-06-05T11:17:56.399455Z","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-05T11:17:56.399539Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-05T11:17:56.399596Z","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-05T11:17:56.399605Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-05T11:17:56.399619Z","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-05T11:17:56.400221Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-06-05T11:17:56.400292Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-05T11:17:56.430744Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"30.282398ms"} {"level":"info","ts":"2026-06-05T11:17:56.453866Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-06-05T11:17:56.453972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T11:17:56.454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-06-05T11:17:56.454014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T11:17:56.454032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-06-05T11:17:56.454083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-06-05T11:17:56.492791Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T11:17:56.503282Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T11:17:56.507103Z","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-05T11:17:56.526347Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T11:17:56.526716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T11:17:56.526868Z","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-05T11:17:56.527018Z","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-05T11:17:56.527039Z","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-05T11:17:56.52868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-06-05T11:17:56.528873Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-05T11:17:56.533811Z","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-05T11:17:56.53387Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-05T11:17:56.533926Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-05T11:17:56.53423Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T11:17:56.534284Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T11:17:56.754691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T11:17:56.754759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T11:17:56.754799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-06-05T11:17:56.754821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-06-05T11:17:56.754833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-05T11:17:56.75485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-06-05T11:17:56.754878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-05T11:17:56.762549Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T11:17:56.76436Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T11:17:56.764573Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T11:17:56.765078Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T11:17:56.765308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T11:17:56.765331Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T11:17:56.768726Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T11:17:56.768837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T11:17:56.768871Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T11:17:56.769306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-06-05T11:17:56.770423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T11:17:58.667564Z","caller":"traceutil/trace.go:171","msg":"trace[792269851] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"213.833371ms","start":"2026-06-05T11:17:58.453701Z","end":"2026-06-05T11:17:58.667534Z","steps":["trace[792269851] 'process raft request' (duration: 161.468274ms)","trace[792269851] 'compare' (duration: 52.026055ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:17:58.668263Z","caller":"traceutil/trace.go:171","msg":"trace[979987978] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"213.485909ms","start":"2026-06-05T11:17:58.454755Z","end":"2026-06-05T11:17:58.668241Z","steps":["trace[979987978] 'process raft request' (duration: 212.753313ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:17:58.668319Z","caller":"traceutil/trace.go:171","msg":"trace[1557027910] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"213.478099ms","start":"2026-06-05T11:17:58.454787Z","end":"2026-06-05T11:17:58.668265Z","steps":["trace[1557027910] 'process raft request' (duration: 213.124007ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:17:58.668557Z","caller":"traceutil/trace.go:171","msg":"trace[629722410] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"213.61561ms","start":"2026-06-05T11:17:58.45492Z","end":"2026-06-05T11:17:58.668535Z","steps":["trace[629722410] 'process raft request' (duration: 213.125137ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:17:58.668672Z","caller":"traceutil/trace.go:171","msg":"trace[1045517465] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"204.87377ms","start":"2026-06-05T11:17:58.463679Z","end":"2026-06-05T11:17:58.668553Z","steps":["trace[1045517465] 'process raft request' (duration: 204.786029ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:17:58.668837Z","caller":"traceutil/trace.go:171","msg":"trace[1603819437] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"213.641871ms","start":"2026-06-05T11:17:58.455183Z","end":"2026-06-05T11:17:58.668825Z","steps":["trace[1603819437] 'process raft request' (duration: 212.994386ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:17:58.669111Z","caller":"traceutil/trace.go:171","msg":"trace[1365053157] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"213.764551ms","start":"2026-06-05T11:17:58.455334Z","end":"2026-06-05T11:17:58.669098Z","steps":["trace[1365053157] 'process raft request' (duration: 212.959506ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:00.291827Z","caller":"traceutil/trace.go:171","msg":"trace[1118619217] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"157.086845ms","start":"2026-06-05T11:18:00.134714Z","end":"2026-06-05T11:18:00.291801Z","steps":["trace[1118619217] 'process raft request' (duration: 157.027392ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:00.291992Z","caller":"traceutil/trace.go:171","msg":"trace[608517712] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"272.515142ms","start":"2026-06-05T11:18:00.01934Z","end":"2026-06-05T11:18:00.291855Z","steps":["trace[608517712] 'process raft request' (duration: 182.660454ms)","trace[608517712] 'compare' (duration: 89.545033ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:01.393996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.01124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T11:18:01.394152Z","caller":"traceutil/trace.go:171","msg":"trace[298755982] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"344.317287ms","start":"2026-06-05T11:18:01.049815Z","end":"2026-06-05T11:18:01.394132Z","steps":["trace[298755982] 'process raft request' (duration: 68.562471ms)","trace[298755982] 'compare' (duration: 274.797779ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:01.39431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:01.049788Z","time spent":"344.467814ms","remote":"127.0.0.1:41236","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-05T11:18:02.572892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04760518s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-06-05T11:18:02.573113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:01.734304Z","time spent":"838.804756ms","remote":"127.0.0.1:41042","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-05T11:18:02.5734Z","caller":"traceutil/trace.go:171","msg":"trace[1517265492] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:220; }","duration":"1.223756814s","start":"2026-06-05T11:18:01.349607Z","end":"2026-06-05T11:18:02.573364Z","steps":["trace[1517265492] 'read index received' (duration: 175.612838ms)","trace[1517265492] 'applied index is now lower than readState.Index' (duration: 1.048142486s)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:02.573455Z","caller":"traceutil/trace.go:171","msg":"trace[1507448108] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"1.441640444s","start":"2026-06-05T11:18:01.131768Z","end":"2026-06-05T11:18:02.573409Z","steps":["trace[1507448108] 'process raft request' (duration: 393.434705ms)","trace[1507448108] 'compare' (duration: 1.04741729s)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:02.573683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004261085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T11:18:02.573679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224054848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-06-05T11:18:02.573773Z","caller":"traceutil/trace.go:171","msg":"trace[695847322] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:216; }","duration":"1.004382232s","start":"2026-06-05T11:18:01.569348Z","end":"2026-06-05T11:18:02.57373Z","steps":["trace[695847322] 'agreement among raft nodes before linearized reading' (duration: 1.004223224s)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:02.573782Z","caller":"traceutil/trace.go:171","msg":"trace[1384027537] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:216; }","duration":"1.224167784s","start":"2026-06-05T11:18:01.349586Z","end":"2026-06-05T11:18:02.573754Z","steps":["trace[1384027537] 'agreement among raft nodes before linearized reading' (duration: 1.223952603s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:02.573836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:01.349494Z","time spent":"1.224334172s","remote":"127.0.0.1:41128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3732,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-05T11:18:02.573883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:01.569322Z","time spent":"1.004525698s","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T11:18:02.573978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:01.131716Z","time spent":"1.441897266s","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T11:18:03.283937Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028386310,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:03.784753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028386310,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:03.855036Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.2787785s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T11:18:03.855427Z","caller":"traceutil/trace.go:171","msg":"trace[1498151349] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"1.279285225s","start":"2026-06-05T11:18:02.576116Z","end":"2026-06-05T11:18:03.855402Z","steps":["trace[1498151349] 'process raft request' (duration: 1.279115427s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:03.855573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:02.57609Z","time spent":"1.27941022s","remote":"127.0.0.1:41042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T11:18:03.860812Z","caller":"traceutil/trace.go:171","msg":"trace[894678997] linearizableReadLoop","detail":"{readStateIndex:225; appliedIndex:222; }","duration":"1.077827197s","start":"2026-06-05T11:18:02.782968Z","end":"2026-06-05T11:18:03.860795Z","steps":["trace[894678997] 'read index received' (duration: 1.072335234s)","trace[894678997] 'applied index is now lower than readState.Index' (duration: 5.490853ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:03.86098Z","caller":"traceutil/trace.go:171","msg":"trace[994618373] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"1.280419357s","start":"2026-06-05T11:18:02.580502Z","end":"2026-06-05T11:18:03.860921Z","steps":["trace[994618373] 'process raft request' (duration: 1.280142374s)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:03.86098Z","caller":"traceutil/trace.go:171","msg":"trace[1911079722] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"1.277743727s","start":"2026-06-05T11:18:02.58316Z","end":"2026-06-05T11:18:03.860903Z","steps":["trace[1911079722] 'process raft request' (duration: 1.277581249s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:03.861103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:02.58048Z","time spent":"1.280560063s","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T11:18:03.86117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:02.583136Z","time spent":"1.277922865s","remote":"127.0.0.1:41128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:03.860996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077946792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:03.861646Z","caller":"traceutil/trace.go:171","msg":"trace[602974666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:219; }","duration":"1.078714929s","start":"2026-06-05T11:18:02.782914Z","end":"2026-06-05T11:18:03.861629Z","steps":["trace[602974666] 'agreement among raft nodes before linearized reading' (duration: 1.077972103s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:03.861714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:02.782884Z","time spent":"1.078809675s","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T11:18:03.862173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.045032ms","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-05T11:18:03.862216Z","caller":"traceutil/trace.go:171","msg":"trace[1850547266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:220; }","duration":"758.164128ms","start":"2026-06-05T11:18:03.104042Z","end":"2026-06-05T11:18:03.862207Z","steps":["trace[1850547266] 'agreement among raft nodes before linearized reading' (duration: 758.048212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:03.862248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:03.10402Z","time spent":"758.222351ms","remote":"127.0.0.1:41236","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-05T11:18:03.862286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.266271ms","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-05T11:18:03.862341Z","caller":"traceutil/trace.go:171","msg":"trace[934984846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:220; }","duration":"463.373477ms","start":"2026-06-05T11:18:03.398954Z","end":"2026-06-05T11:18:03.862328Z","steps":["trace[934984846] 'agreement among raft nodes before linearized reading' (duration: 463.259791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:03.862379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:03.398907Z","time spent":"463.465051ms","remote":"127.0.0.1:41236","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-05T11:18:32.278192Z","caller":"traceutil/trace.go:171","msg":"trace[1441845020] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"199.187944ms","start":"2026-06-05T11:18:32.078982Z","end":"2026-06-05T11:18:32.27817Z","steps":["trace[1441845020] 'process raft request' (duration: 199.07258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:32.418799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.927496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T11:18:32.418896Z","caller":"traceutil/trace.go:171","msg":"trace[1945515984] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:506; }","duration":"335.838052ms","start":"2026-06-05T11:18:32.083044Z","end":"2026-06-05T11:18:32.418882Z","steps":["trace[1945515984] 'read index received' (duration: 195.020851ms)","trace[1945515984] 'applied index is now lower than readState.Index' (duration: 140.816091ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:32.418991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.947965ms","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-05T11:18:32.418963Z","caller":"traceutil/trace.go:171","msg":"trace[877810541] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"339.145806ms","start":"2026-06-05T11:18:32.079763Z","end":"2026-06-05T11:18:32.418909Z","steps":["trace[877810541] 'process raft request' (duration: 228.014874ms)","trace[877810541] 'compare' (duration: 110.850052ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:32.419042Z","caller":"traceutil/trace.go:171","msg":"trace[450968945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:488; }","duration":"336.032488ms","start":"2026-06-05T11:18:32.082998Z","end":"2026-06-05T11:18:32.419031Z","steps":["trace[450968945] 'agreement among raft nodes before linearized reading' (duration: 335.956105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:32.419076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:32.082983Z","time spent":"336.08502ms","remote":"127.0.0.1:41236","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-05T11:18:32.419138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.056195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-05T11:18:32.419186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:32.079752Z","time spent":"339.309341ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:32.419241Z","caller":"traceutil/trace.go:171","msg":"trace[50124480] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:488; }","duration":"335.18046ms","start":"2026-06-05T11:18:32.084025Z","end":"2026-06-05T11:18:32.419205Z","steps":["trace[50124480] 'agreement among raft nodes before linearized reading' (duration: 335.003613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:32.419289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:32.08401Z","time spent":"335.269843ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T11:18:36.257566Z","caller":"traceutil/trace.go:171","msg":"trace[1098327939] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"242.66533ms","start":"2026-06-05T11:18:36.014857Z","end":"2026-06-05T11:18:36.257523Z","steps":["trace[1098327939] 'process raft request' (duration: 242.463144ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267584Z","caller":"traceutil/trace.go:171","msg":"trace[892362159] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"216.304653ms","start":"2026-06-05T11:18:36.051264Z","end":"2026-06-05T11:18:36.267568Z","steps":["trace[892362159] 'process raft request' (duration: 216.165108ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267845Z","caller":"traceutil/trace.go:171","msg":"trace[1355793125] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"200.547374ms","start":"2026-06-05T11:18:36.06728Z","end":"2026-06-05T11:18:36.267827Z","steps":["trace[1355793125] 'process raft request' (duration: 200.372978ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267564Z","caller":"traceutil/trace.go:171","msg":"trace[1721386047] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"245.716059ms","start":"2026-06-05T11:18:36.021812Z","end":"2026-06-05T11:18:36.267528Z","steps":["trace[1721386047] 'process raft request' (duration: 245.569535ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267637Z","caller":"traceutil/trace.go:171","msg":"trace[180233934] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"246.439624ms","start":"2026-06-05T11:18:36.021185Z","end":"2026-06-05T11:18:36.267625Z","steps":["trace[180233934] 'process raft request' (duration: 246.081782ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267795Z","caller":"traceutil/trace.go:171","msg":"trace[291466591] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"204.818145ms","start":"2026-06-05T11:18:36.062941Z","end":"2026-06-05T11:18:36.267759Z","steps":["trace[291466591] 'process raft request' (duration: 204.612048ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267645Z","caller":"traceutil/trace.go:171","msg":"trace[1833129991] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"216.281591ms","start":"2026-06-05T11:18:36.051333Z","end":"2026-06-05T11:18:36.267615Z","steps":["trace[1833129991] 'process raft request' (duration: 216.140137ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.267678Z","caller":"traceutil/trace.go:171","msg":"trace[1036956530] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"216.201949ms","start":"2026-06-05T11:18:36.051424Z","end":"2026-06-05T11:18:36.267626Z","steps":["trace[1036956530] 'process raft request' (duration: 216.089885ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.26813Z","caller":"traceutil/trace.go:171","msg":"trace[546927854] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"198.652992ms","start":"2026-06-05T11:18:36.069468Z","end":"2026-06-05T11:18:36.268121Z","steps":["trace[546927854] 'process raft request' (duration: 198.29547ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.268226Z","caller":"traceutil/trace.go:171","msg":"trace[456733242] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"180.9868ms","start":"2026-06-05T11:18:36.087213Z","end":"2026-06-05T11:18:36.268199Z","steps":["trace[456733242] 'process raft request' (duration: 180.815805ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.268744Z","caller":"traceutil/trace.go:171","msg":"trace[1385880666] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"173.282599ms","start":"2026-06-05T11:18:36.095449Z","end":"2026-06-05T11:18:36.268732Z","steps":["trace[1385880666] 'process raft request' (duration: 172.704949ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.547736Z","caller":"traceutil/trace.go:171","msg":"trace[1857276789] transaction","detail":"{read_only:false; number_of_response:1; response_revision:557; }","duration":"179.919145ms","start":"2026-06-05T11:18:36.367753Z","end":"2026-06-05T11:18:36.547672Z","steps":["trace[1857276789] 'process raft request' (duration: 88.881162ms)","trace[1857276789] 'compare' (duration: 90.92069ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:36.616312Z","caller":"traceutil/trace.go:171","msg":"trace[913369672] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"240.002413ms","start":"2026-06-05T11:18:36.376269Z","end":"2026-06-05T11:18:36.616272Z","steps":["trace[913369672] 'process raft request' (duration: 239.522737ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.616367Z","caller":"traceutil/trace.go:171","msg":"trace[1634994202] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"186.08186ms","start":"2026-06-05T11:18:36.430256Z","end":"2026-06-05T11:18:36.616337Z","steps":["trace[1634994202] 'read index received' (duration: 26.4423ms)","trace[1634994202] 'applied index is now lower than readState.Index' (duration: 159.63854ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:36.616739Z","caller":"traceutil/trace.go:171","msg":"trace[1973708965] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"205.890611ms","start":"2026-06-05T11:18:36.410832Z","end":"2026-06-05T11:18:36.616723Z","steps":["trace[1973708965] 'process raft request' (duration: 205.352433ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.616909Z","caller":"traceutil/trace.go:171","msg":"trace[2060054565] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"238.483952ms","start":"2026-06-05T11:18:36.378414Z","end":"2026-06-05T11:18:36.616897Z","steps":["trace[2060054565] 'process raft request' (duration: 237.644215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:36.616994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.71329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-05T11:18:36.617069Z","caller":"traceutil/trace.go:171","msg":"trace[188654583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:560; }","duration":"186.845024ms","start":"2026-06-05T11:18:36.430204Z","end":"2026-06-05T11:18:36.617049Z","steps":["trace[188654583] 'agreement among raft nodes before linearized reading' (duration: 186.619277ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.795237Z","caller":"traceutil/trace.go:171","msg":"trace[102183126] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"178.774979ms","start":"2026-06-05T11:18:36.616437Z","end":"2026-06-05T11:18:36.795212Z","steps":["trace[102183126] 'read index received' (duration: 107.988001ms)","trace[102183126] 'applied index is now lower than readState.Index' (duration: 70.785788ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:36.795324Z","caller":"traceutil/trace.go:171","msg":"trace[611271203] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"238.154131ms","start":"2026-06-05T11:18:36.557123Z","end":"2026-06-05T11:18:36.795277Z","steps":["trace[611271203] 'process raft request' (duration: 167.213938ms)","trace[611271203] 'compare' (duration: 70.737806ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:36.795486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.157601ms","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-05T11:18:36.795531Z","caller":"traceutil/trace.go:171","msg":"trace[1244346325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"345.253104ms","start":"2026-06-05T11:18:36.450267Z","end":"2026-06-05T11:18:36.79552Z","steps":["trace[1244346325] 'agreement among raft nodes before linearized reading' (duration: 345.038927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:36.795574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:36.450252Z","time spent":"345.313995ms","remote":"127.0.0.1:41236","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-05T11:18:36.795833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.326241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T11:18:36.795929Z","caller":"traceutil/trace.go:171","msg":"trace[852287369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"312.459574ms","start":"2026-06-05T11:18:36.483446Z","end":"2026-06-05T11:18:36.795906Z","steps":["trace[852287369] 'agreement among raft nodes before linearized reading' (duration: 312.083162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:36.79599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:36.483436Z","time spent":"312.541378ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T11:18:36.826572Z","caller":"traceutil/trace.go:171","msg":"trace[665850471] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"202.632713ms","start":"2026-06-05T11:18:36.623916Z","end":"2026-06-05T11:18:36.826549Z","steps":["trace[665850471] 'process raft request' (duration: 202.390955ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.826717Z","caller":"traceutil/trace.go:171","msg":"trace[1349497332] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"194.184025ms","start":"2026-06-05T11:18:36.632497Z","end":"2026-06-05T11:18:36.826681Z","steps":["trace[1349497332] 'process raft request' (duration: 193.954368ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.826878Z","caller":"traceutil/trace.go:171","msg":"trace[1798525836] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"115.929292ms","start":"2026-06-05T11:18:36.710926Z","end":"2026-06-05T11:18:36.826855Z","steps":["trace[1798525836] 'process raft request' (duration: 115.726126ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:36.827091Z","caller":"traceutil/trace.go:171","msg":"trace[1707054985] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"188.777957ms","start":"2026-06-05T11:18:36.638284Z","end":"2026-06-05T11:18:36.827062Z","steps":["trace[1707054985] 'process raft request' (duration: 188.25278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:37.543472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028387001,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:38.044139Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028387001,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:38.062631Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.171177729s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T11:18:38.063208Z","caller":"traceutil/trace.go:171","msg":"trace[1895466074] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"1.222018129s","start":"2026-06-05T11:18:36.841171Z","end":"2026-06-05T11:18:38.063189Z","steps":["trace[1895466074] 'process raft request' (duration: 1.221702319s)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:38.063226Z","caller":"traceutil/trace.go:171","msg":"trace[1526410444] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"1.183261016s","start":"2026-06-05T11:18:36.879928Z","end":"2026-06-05T11:18:38.063189Z","steps":["trace[1526410444] 'process raft request' (duration: 1.183186473s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:38.063316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:36.841146Z","time spent":"1.222102742s","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:38.063394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:36.879902Z","time spent":"1.18339813s","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T11:18:38.067332Z","caller":"traceutil/trace.go:171","msg":"trace[520488727] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:593; }","duration":"1.024116214s","start":"2026-06-05T11:18:37.043182Z","end":"2026-06-05T11:18:38.067298Z","steps":["trace[520488727] 'read index received' (duration: 1.019703341s)","trace[520488727] 'applied index is now lower than readState.Index' (duration: 4.411353ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:38.067522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02431247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:38.067559Z","caller":"traceutil/trace.go:171","msg":"trace[1769672048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"1.024427344s","start":"2026-06-05T11:18:37.043119Z","end":"2026-06-05T11:18:38.067546Z","steps":["trace[1769672048] 'agreement among raft nodes before linearized reading' (duration: 1.02430164s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:38.067599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:37.043089Z","time spent":"1.024500536s","remote":"127.0.0.1:40968","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-05T11:18:38.068068Z","caller":"traceutil/trace.go:171","msg":"trace[2064858684] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"1.165122716s","start":"2026-06-05T11:18:36.902933Z","end":"2026-06-05T11:18:38.068055Z","steps":["trace[2064858684] 'process raft request' (duration: 1.164174186s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:38.068188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:36.902892Z","time spent":"1.165205578s","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:38.589795Z","caller":"traceutil/trace.go:171","msg":"trace[2122823858] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"154.63151ms","start":"2026-06-05T11:18:38.435102Z","end":"2026-06-05T11:18:38.589733Z","steps":["trace[2122823858] 'process raft request' (duration: 118.365282ms)","trace[2122823858] 'compare' (duration: 35.935907ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:43.149163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.126648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:43.149348Z","caller":"traceutil/trace.go:171","msg":"trace[1088716826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"108.377226ms","start":"2026-06-05T11:18:43.040949Z","end":"2026-06-05T11:18:43.149326Z","steps":["trace[1088716826] 'range keys from in-memory index tree' (duration: 108.052296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.149479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.382353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-05T11:18:43.149505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.554958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T11:18:43.149555Z","caller":"traceutil/trace.go:171","msg":"trace[707370237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"196.507747ms","start":"2026-06-05T11:18:42.95303Z","end":"2026-06-05T11:18:43.149538Z","steps":["trace[707370237] 'range keys from in-memory index tree' (duration: 196.215508ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:43.149579Z","caller":"traceutil/trace.go:171","msg":"trace[915898476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"195.62453ms","start":"2026-06-05T11:18:42.953919Z","end":"2026-06-05T11:18:43.149544Z","steps":["trace[915898476] 'range keys from in-memory index tree' (duration: 195.387533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.14973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.491442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-05T11:18:43.149762Z","caller":"traceutil/trace.go:171","msg":"trace[828193301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"280.576525ms","start":"2026-06-05T11:18:42.869176Z","end":"2026-06-05T11:18:43.149752Z","steps":["trace[828193301] 'range keys from in-memory index tree' (duration: 280.377519ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:43.284382Z","caller":"traceutil/trace.go:171","msg":"trace[1347246338] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"130.695518ms","start":"2026-06-05T11:18:43.153658Z","end":"2026-06-05T11:18:43.284353Z","steps":["trace[1347246338] 'process raft request' (duration: 130.212194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.667757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.939159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T11:18:43.668017Z","caller":"traceutil/trace.go:171","msg":"trace[178536300] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"315.899865ms","start":"2026-06-05T11:18:43.352084Z","end":"2026-06-05T11:18:43.667984Z","steps":["trace[178536300] 'read index received' (duration: 28.525803ms)","trace[178536300] 'applied index is now lower than readState.Index' (duration: 287.373092ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:43.668986Z","caller":"traceutil/trace.go:171","msg":"trace[717613609] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"514.723656ms","start":"2026-06-05T11:18:43.154249Z","end":"2026-06-05T11:18:43.668972Z","steps":["trace[717613609] 'process raft request' (duration: 226.472247ms)","trace[717613609] 'compare' (duration: 286.598009ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:43.669055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:43.154234Z","time spent":"514.793479ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:43.669053Z","caller":"traceutil/trace.go:171","msg":"trace[201771801] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"514.155909ms","start":"2026-06-05T11:18:43.154858Z","end":"2026-06-05T11:18:43.669014Z","steps":["trace[201771801] 'process raft request' (duration: 513.079417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.669272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.437039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kk9jp\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-05T11:18:43.669358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:43.154848Z","time spent":"514.393986ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:43.669402Z","caller":"traceutil/trace.go:171","msg":"trace[1326728572] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kk9jp; range_end:; response_count:1; response_revision:629; }","duration":"231.614176ms","start":"2026-06-05T11:18:43.437771Z","end":"2026-06-05T11:18:43.669386Z","steps":["trace[1326728572] 'agreement among raft nodes before linearized reading' (duration: 231.387079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.669419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.315948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:43.669498Z","caller":"traceutil/trace.go:171","msg":"trace[5517688] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:629; }","duration":"317.431261ms","start":"2026-06-05T11:18:43.352047Z","end":"2026-06-05T11:18:43.669478Z","steps":["trace[5517688] 'agreement among raft nodes before linearized reading' (duration: 317.290467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.669547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:43.35203Z","time spent":"317.505563ms","remote":"127.0.0.1:41158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-06-05T11:18:43.669551Z","caller":"traceutil/trace.go:171","msg":"trace[1064804193] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"514.907942ms","start":"2026-06-05T11:18:43.15463Z","end":"2026-06-05T11:18:43.669538Z","steps":["trace[1064804193] 'process raft request' (duration: 513.226401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:43.669691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:43.154618Z","time spent":"514.995035ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:44.87849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028387170,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:45.379273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202746028387170,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T11:18:45.55716Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.875384258s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-05T11:18:45.560625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.812965ms","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-05T11:18:45.560739Z","caller":"traceutil/trace.go:171","msg":"trace[208390423] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:629; }","duration":"765.935659ms","start":"2026-06-05T11:18:44.794786Z","end":"2026-06-05T11:18:45.560721Z","steps":["trace[208390423] 'range keys from in-memory index tree' (duration: 765.797565ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:45.561632Z","caller":"traceutil/trace.go:171","msg":"trace[602500660] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.879891954s","start":"2026-06-05T11:18:43.681686Z","end":"2026-06-05T11:18:45.561578Z","steps":["trace[602500660] 'process raft request' (duration: 1.875742979s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:45.561846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:43.681668Z","time spent":"1.880061249s","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:45.571343Z","caller":"traceutil/trace.go:171","msg":"trace[2088117180] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.49484697s","start":"2026-06-05T11:18:44.076478Z","end":"2026-06-05T11:18:45.571325Z","steps":["trace[2088117180] 'process raft request' (duration: 1.494027296s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:45.571464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:44.076452Z","time spent":"1.494948743s","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:45.595294Z","caller":"traceutil/trace.go:171","msg":"trace[1834341774] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:655; }","duration":"1.21739646s","start":"2026-06-05T11:18:44.377874Z","end":"2026-06-05T11:18:45.595271Z","steps":["trace[1834341774] 'read index received' (duration: 1.179573616s)","trace[1834341774] 'applied index is now lower than readState.Index' (duration: 37.821644ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:45.59567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.562979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T11:18:45.595702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217811253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-05T11:18:45.595736Z","caller":"traceutil/trace.go:171","msg":"trace[813369407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.217904756s","start":"2026-06-05T11:18:44.377823Z","end":"2026-06-05T11:18:45.595728Z","steps":["trace[813369407] 'agreement among raft nodes before linearized reading' (duration: 1.217750951s)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:45.595748Z","caller":"traceutil/trace.go:171","msg":"trace[1962921683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"553.684642ms","start":"2026-06-05T11:18:45.042041Z","end":"2026-06-05T11:18:45.595726Z","steps":["trace[1962921683] 'agreement among raft nodes before linearized reading' (duration: 553.530447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:45.59576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:44.377801Z","time spent":"1.217953198s","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T11:18:45.595898Z","caller":"traceutil/trace.go:171","msg":"trace[714094512] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"371.690096ms","start":"2026-06-05T11:18:45.224202Z","end":"2026-06-05T11:18:45.595892Z","steps":["trace[714094512] 'process raft request' (duration: 370.891262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:45.595983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:45.224174Z","time spent":"371.746677ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:45.595785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:45.042023Z","time spent":"553.756494ms","remote":"127.0.0.1:40968","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-05T11:18:47.288706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.052481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:47.288823Z","caller":"traceutil/trace.go:171","msg":"trace[368701731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"246.220036ms","start":"2026-06-05T11:18:47.04258Z","end":"2026-06-05T11:18:47.2888Z","steps":["trace[368701731] 'range keys from in-memory index tree' (duration: 245.954358ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:47.309721Z","caller":"traceutil/trace.go:171","msg":"trace[1727080434] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"199.658968ms","start":"2026-06-05T11:18:47.110036Z","end":"2026-06-05T11:18:47.309695Z","steps":["trace[1727080434] 'process raft request' (duration: 198.931627ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:48.182814Z","caller":"traceutil/trace.go:171","msg":"trace[1247169537] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"298.780121ms","start":"2026-06-05T11:18:47.884011Z","end":"2026-06-05T11:18:48.182792Z","steps":["trace[1247169537] 'process raft request' (duration: 298.661947ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:48.202377Z","caller":"traceutil/trace.go:171","msg":"trace[683977526] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"310.478649ms","start":"2026-06-05T11:18:47.891862Z","end":"2026-06-05T11:18:48.202341Z","steps":["trace[683977526] 'process raft request' (duration: 309.721776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:48.202574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:47.891837Z","time spent":"310.648573ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:48.202664Z","caller":"traceutil/trace.go:171","msg":"trace[375005407] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"119.397015ms","start":"2026-06-05T11:18:48.083232Z","end":"2026-06-05T11:18:48.202629Z","steps":["trace[375005407] 'process raft request' (duration: 118.988294ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:48.453766Z","caller":"traceutil/trace.go:171","msg":"trace[1561760409] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"192.875554ms","start":"2026-06-05T11:18:48.260862Z","end":"2026-06-05T11:18:48.453737Z","steps":["trace[1561760409] 'process raft request' (duration: 134.535926ms)","trace[1561760409] 'compare' (duration: 58.189944ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:48.458289Z","caller":"traceutil/trace.go:171","msg":"trace[169517808] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"173.780688ms","start":"2026-06-05T11:18:48.2845Z","end":"2026-06-05T11:18:48.458281Z","steps":["trace[169517808] 'process raft request' (duration: 173.741237ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:48.458452Z","caller":"traceutil/trace.go:171","msg":"trace[1557290418] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"194.314946ms","start":"2026-06-05T11:18:48.264131Z","end":"2026-06-05T11:18:48.458446Z","steps":["trace[1557290418] 'process raft request' (duration: 194.026767ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:48.824038Z","caller":"traceutil/trace.go:171","msg":"trace[1176816482] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"146.317918ms","start":"2026-06-05T11:18:48.677686Z","end":"2026-06-05T11:18:48.824004Z","steps":["trace[1176816482] 'process raft request' (duration: 77.956899ms)","trace[1176816482] 'compare' (duration: 68.225155ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:48.860118Z","caller":"traceutil/trace.go:171","msg":"trace[1477172112] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"174.833838ms","start":"2026-06-05T11:18:48.685259Z","end":"2026-06-05T11:18:48.860092Z","steps":["trace[1477172112] 'process raft request' (duration: 174.690574ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:49.081493Z","caller":"traceutil/trace.go:171","msg":"trace[2036282137] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"214.532211ms","start":"2026-06-05T11:18:48.866932Z","end":"2026-06-05T11:18:49.081464Z","steps":["trace[2036282137] 'process raft request' (duration: 213.859092ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:49.091086Z","caller":"traceutil/trace.go:171","msg":"trace[346878475] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"220.235766ms","start":"2026-06-05T11:18:48.870825Z","end":"2026-06-05T11:18:49.09106Z","steps":["trace[346878475] 'process raft request' (duration: 219.983469ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:49.09147Z","caller":"traceutil/trace.go:171","msg":"trace[1412722883] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"209.177193ms","start":"2026-06-05T11:18:48.882275Z","end":"2026-06-05T11:18:49.091452Z","steps":["trace[1412722883] 'process raft request' (duration: 208.71536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.515319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.220782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T11:18:49.515554Z","caller":"traceutil/trace.go:171","msg":"trace[908306773] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"374.719798ms","start":"2026-06-05T11:18:49.140818Z","end":"2026-06-05T11:18:49.515538Z","steps":["trace[908306773] 'process raft request' (duration: 374.678887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.515618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.14081Z","time spent":"374.782059ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T11:18:49.515853Z","caller":"traceutil/trace.go:171","msg":"trace[1622967498] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"409.048128ms","start":"2026-06-05T11:18:49.106783Z","end":"2026-06-05T11:18:49.515831Z","steps":["trace[1622967498] 'process raft request' (duration: 408.634516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.516011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.106757Z","time spent":"409.188042ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:49.516153Z","caller":"traceutil/trace.go:171","msg":"trace[1040153130] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"419.878931ms","start":"2026-06-05T11:18:49.09626Z","end":"2026-06-05T11:18:49.516139Z","steps":["trace[1040153130] 'process raft request' (duration: 313.742932ms)","trace[1040153130] 'compare' (duration: 105.037227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:49.516224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.096243Z","time spent":"419.945612ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:49.611668Z","caller":"traceutil/trace.go:171","msg":"trace[1632631579] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:719; }","duration":"138.667576ms","start":"2026-06-05T11:18:49.472975Z","end":"2026-06-05T11:18:49.611642Z","steps":["trace[1632631579] 'read index received' (duration: 138.549763ms)","trace[1632631579] 'applied index is now lower than readState.Index' (duration: 116.533µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:49.611751Z","caller":"traceutil/trace.go:171","msg":"trace[1361329449] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"326.037467ms","start":"2026-06-05T11:18:49.285682Z","end":"2026-06-05T11:18:49.61172Z","steps":["trace[1361329449] 'process raft request' (duration: 325.855172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.611905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.915424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kk9jp\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-06-05T11:18:49.611949Z","caller":"traceutil/trace.go:171","msg":"trace[1522685788] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kk9jp; range_end:; response_count:1; response_revision:693; }","duration":"139.001796ms","start":"2026-06-05T11:18:49.472935Z","end":"2026-06-05T11:18:49.611937Z","steps":["trace[1522685788] 'agreement among raft nodes before linearized reading' (duration: 138.82095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.611976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.285656Z","time spent":"326.17491ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T11:18:49.901431Z","caller":"traceutil/trace.go:171","msg":"trace[124968617] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"427.320355ms","start":"2026-06-05T11:18:49.474083Z","end":"2026-06-05T11:18:49.901403Z","steps":["trace[124968617] 'process raft request' (duration: 427.12027ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:49.901468Z","caller":"traceutil/trace.go:171","msg":"trace[567734151] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:720; }","duration":"289.695699ms","start":"2026-06-05T11:18:49.611736Z","end":"2026-06-05T11:18:49.901432Z","steps":["trace[567734151] 'read index received' (duration: 289.547825ms)","trace[567734151] 'applied index is now lower than readState.Index' (duration: 146.334µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:49.901513Z","caller":"traceutil/trace.go:171","msg":"trace[1984768984] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"377.721576ms","start":"2026-06-05T11:18:49.523756Z","end":"2026-06-05T11:18:49.901478Z","steps":["trace[1984768984] 'process raft request' (duration: 377.635904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.901679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.523736Z","time spent":"377.856461ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:49.90161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.858202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:49.901779Z","caller":"traceutil/trace.go:171","msg":"trace[1496911462] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"380.244789ms","start":"2026-06-05T11:18:49.521513Z","end":"2026-06-05T11:18:49.901757Z","steps":["trace[1496911462] 'process raft request' (duration: 379.805487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.901745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.474064Z","time spent":"427.445738ms","remote":"127.0.0.1:41042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":771,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T11:18:49.901805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.432367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T11:18:49.901883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.521492Z","time spent":"380.336061ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:49.901887Z","caller":"traceutil/trace.go:171","msg":"trace[622414014] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:696; }","duration":"420.54419ms","start":"2026-06-05T11:18:49.48132Z","end":"2026-06-05T11:18:49.901864Z","steps":["trace[622414014] 'agreement among raft nodes before linearized reading' (duration: 420.379606ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:49.901846Z","caller":"traceutil/trace.go:171","msg":"trace[2117597618] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:696; }","duration":"376.022397ms","start":"2026-06-05T11:18:49.525703Z","end":"2026-06-05T11:18:49.901726Z","steps":["trace[2117597618] 'agreement among raft nodes before linearized reading' (duration: 375.859033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.901943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.481311Z","time spent":"420.622372ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-05T11:18:49.901964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.525694Z","time spent":"376.257074ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-06-05T11:18:49.980879Z","caller":"traceutil/trace.go:171","msg":"trace[1772199699] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"353.121448ms","start":"2026-06-05T11:18:49.62773Z","end":"2026-06-05T11:18:49.980852Z","steps":["trace[1772199699] 'process raft request' (duration: 352.863701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.981043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.627708Z","time spent":"353.257702ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:49.982004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.218757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-05T11:18:49.982111Z","caller":"traceutil/trace.go:171","msg":"trace[1603195013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:698; }","duration":"263.354511ms","start":"2026-06-05T11:18:49.718735Z","end":"2026-06-05T11:18:49.982089Z","steps":["trace[1603195013] 'agreement among raft nodes before linearized reading' (duration: 263.105674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.98208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.485024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T11:18:49.982921Z","caller":"traceutil/trace.go:171","msg":"trace[1824448506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:698; }","duration":"281.37983ms","start":"2026-06-05T11:18:49.701529Z","end":"2026-06-05T11:18:49.982909Z","steps":["trace[1824448506] 'agreement among raft nodes before linearized reading' (duration: 280.388031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.982247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.858532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-05T11:18:49.983195Z","caller":"traceutil/trace.go:171","msg":"trace[908148184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:698; }","duration":"334.804039ms","start":"2026-06-05T11:18:49.64838Z","end":"2026-06-05T11:18:49.983184Z","steps":["trace[908148184] 'agreement among raft nodes before linearized reading' (duration: 333.695878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.983271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.648322Z","time spent":"334.936183ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T11:18:49.982289Z","caller":"traceutil/trace.go:171","msg":"trace[864774009] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"284.884631ms","start":"2026-06-05T11:18:49.697385Z","end":"2026-06-05T11:18:49.982269Z","steps":["trace[864774009] 'process raft request' (duration: 283.340476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.982349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.834084ms","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-05T11:18:49.983544Z","caller":"traceutil/trace.go:171","msg":"trace[2045900567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:698; }","duration":"282.049889ms","start":"2026-06-05T11:18:49.701485Z","end":"2026-06-05T11:18:49.983535Z","steps":["trace[2045900567] 'agreement among raft nodes before linearized reading' (duration: 280.799214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.982001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.032168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:18:49.983683Z","caller":"traceutil/trace.go:171","msg":"trace[2010284090] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:698; }","duration":"301.774167ms","start":"2026-06-05T11:18:49.681889Z","end":"2026-06-05T11:18:49.983664Z","steps":["trace[2010284090] 'agreement among raft nodes before linearized reading' (duration: 299.999386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.983745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.681877Z","time spent":"301.85767ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-05T11:18:49.982489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.26806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-06-05T11:18:49.98402Z","caller":"traceutil/trace.go:171","msg":"trace[1206432032] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:698; }","duration":"101.725903ms","start":"2026-06-05T11:18:49.882169Z","end":"2026-06-05T11:18:49.983895Z","steps":["trace[1206432032] 'agreement among raft nodes before linearized reading' (duration: 100.211938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:49.982024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.317048ms","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-05T11:18:49.985159Z","caller":"traceutil/trace.go:171","msg":"trace[2029786529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:698; }","duration":"292.646116ms","start":"2026-06-05T11:18:49.691672Z","end":"2026-06-05T11:18:49.984319Z","steps":["trace[2029786529] 'agreement among raft nodes before linearized reading' (duration: 290.207545ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:50.22232Z","caller":"traceutil/trace.go:171","msg":"trace[1131906729] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"312.388863ms","start":"2026-06-05T11:18:49.909907Z","end":"2026-06-05T11:18:50.222296Z","steps":["trace[1131906729] 'process raft request' (duration: 312.091784ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:50.222669Z","caller":"traceutil/trace.go:171","msg":"trace[1431993130] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"307.333077ms","start":"2026-06-05T11:18:49.915316Z","end":"2026-06-05T11:18:50.222649Z","steps":["trace[1431993130] 'process raft request' (duration: 306.907565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.222776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.569266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-05T11:18:50.22278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.915294Z","time spent":"307.430351ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:50.22283Z","caller":"traceutil/trace.go:171","msg":"trace[1030202363] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:700; }","duration":"289.665249ms","start":"2026-06-05T11:18:49.933152Z","end":"2026-06-05T11:18:50.222817Z","steps":["trace[1030202363] 'agreement among raft nodes before linearized reading' (duration: 289.486884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.222954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.90989Z","time spent":"312.510817ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:50.222977Z","caller":"traceutil/trace.go:171","msg":"trace[312410044] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:725; }","duration":"240.575104ms","start":"2026-06-05T11:18:49.981839Z","end":"2026-06-05T11:18:50.222415Z","steps":["trace[312410044] 'read index received' (duration: 240.263835ms)","trace[312410044] 'applied index is now lower than readState.Index' (duration: 309.369µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:18:50.288625Z","caller":"traceutil/trace.go:171","msg":"trace[219145625] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"301.104449ms","start":"2026-06-05T11:18:49.987498Z","end":"2026-06-05T11:18:50.288602Z","steps":["trace[219145625] 'process raft request' (duration: 300.902093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.288768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.987478Z","time spent":"301.214932ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:50.289112Z","caller":"traceutil/trace.go:171","msg":"trace[1235232901] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"300.751489ms","start":"2026-06-05T11:18:49.988334Z","end":"2026-06-05T11:18:50.289086Z","steps":["trace[1235232901] 'process raft request' (duration: 300.195403ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:50.289187Z","caller":"traceutil/trace.go:171","msg":"trace[1180668486] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"299.991627ms","start":"2026-06-05T11:18:49.989186Z","end":"2026-06-05T11:18:50.289177Z","steps":["trace[1180668486] 'process raft request' (duration: 299.822163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.289289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.98917Z","time spent":"300.071429ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:50.289323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.988318Z","time spent":"300.865933ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:50.289447Z","caller":"traceutil/trace.go:171","msg":"trace[182283926] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"299.770281ms","start":"2026-06-05T11:18:49.989666Z","end":"2026-06-05T11:18:50.289437Z","steps":["trace[182283926] 'process raft request' (duration: 299.386519ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:50.289144Z","caller":"traceutil/trace.go:171","msg":"trace[111553435] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"300.027428ms","start":"2026-06-05T11:18:49.989101Z","end":"2026-06-05T11:18:50.289129Z","steps":["trace[111553435] 'process raft request' (duration: 299.841493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.289546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.989081Z","time spent":"300.425351ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T11:18:50.289602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.286926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-06-05T11:18:50.289634Z","caller":"traceutil/trace.go:171","msg":"trace[2069684681] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:705; }","duration":"208.377568ms","start":"2026-06-05T11:18:50.081246Z","end":"2026-06-05T11:18:50.289624Z","steps":["trace[2069684681] 'agreement among raft nodes before linearized reading' (duration: 208.257495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.289748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-xctjp\" ","response":"range_response_count:1 size:4888"} {"level":"info","ts":"2026-06-05T11:18:50.289794Z","caller":"traceutil/trace.go:171","msg":"trace[1598846859] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-xctjp; range_end:; response_count:1; response_revision:705; }","duration":"304.664012ms","start":"2026-06-05T11:18:49.985115Z","end":"2026-06-05T11:18:50.289779Z","steps":["trace[1598846859] 'agreement among raft nodes before linearized reading' (duration: 304.516398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.28983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:49.985097Z","time spent":"304.723893ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4911,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-xctjp\" "} {"level":"info","ts":"2026-06-05T11:18:50.557345Z","caller":"traceutil/trace.go:171","msg":"trace[382141402] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:732; }","duration":"268.228967ms","start":"2026-06-05T11:18:50.289096Z","end":"2026-06-05T11:18:50.557325Z","steps":["trace[382141402] 'read index received' (duration: 235.688549ms)","trace[382141402] 'applied index is now lower than readState.Index' (duration: 32.539478ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:18:50.557452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:50.231889Z","time spent":"325.559622ms","remote":"127.0.0.1:40994","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-05T11:18:50.557683Z","caller":"traceutil/trace.go:171","msg":"trace[424893088] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"318.969575ms","start":"2026-06-05T11:18:50.238681Z","end":"2026-06-05T11:18:50.557651Z","steps":["trace[424893088] 'process raft request' (duration: 318.520952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.557859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.346927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-06-05T11:18:50.557916Z","caller":"traceutil/trace.go:171","msg":"trace[1903403398] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:706; }","duration":"277.430959ms","start":"2026-06-05T11:18:50.280467Z","end":"2026-06-05T11:18:50.557898Z","steps":["trace[1903403398] 'agreement among raft nodes before linearized reading' (duration: 277.231213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.558085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:18:50.238672Z","time spent":"319.100098ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T11:18:50.591756Z","caller":"traceutil/trace.go:171","msg":"trace[804707208] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"293.26239ms","start":"2026-06-05T11:18:50.298461Z","end":"2026-06-05T11:18:50.591723Z","steps":["trace[804707208] 'process raft request' (duration: 293.072585ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:50.596224Z","caller":"traceutil/trace.go:171","msg":"trace[1791923699] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"293.524729ms","start":"2026-06-05T11:18:50.302629Z","end":"2026-06-05T11:18:50.596153Z","steps":["trace[1791923699] 'process raft request' (duration: 290.116322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:18:50.596795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.707433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-05T11:18:50.596873Z","caller":"traceutil/trace.go:171","msg":"trace[751885358] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"114.824607ms","start":"2026-06-05T11:18:50.482031Z","end":"2026-06-05T11:18:50.596856Z","steps":["trace[751885358] 'agreement among raft nodes before linearized reading' (duration: 114.550419ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:51.864412Z","caller":"traceutil/trace.go:171","msg":"trace[1888312219] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"151.77389ms","start":"2026-06-05T11:18:51.712617Z","end":"2026-06-05T11:18:51.864391Z","steps":["trace[1888312219] 'process raft request' (duration: 151.561104ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:18:51.874573Z","caller":"traceutil/trace.go:171","msg":"trace[392403633] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"157.368188ms","start":"2026-06-05T11:18:51.717167Z","end":"2026-06-05T11:18:51.874535Z","steps":["trace[392403633] 'process raft request' (duration: 157.153202ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:00.635273Z","caller":"traceutil/trace.go:171","msg":"trace[839795573] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"245.082617ms","start":"2026-06-05T11:19:00.390171Z","end":"2026-06-05T11:19:00.635254Z","steps":["trace[839795573] 'read index received' (duration: 245.009816ms)","trace[839795573] 'applied index is now lower than readState.Index' (duration: 71.831µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:19:00.635329Z","caller":"traceutil/trace.go:171","msg":"trace[525121261] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"252.658904ms","start":"2026-06-05T11:19:00.382641Z","end":"2026-06-05T11:19:00.6353Z","steps":["trace[525121261] 'process raft request' (duration: 252.486999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:19:00.635591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.418526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T11:19:00.635636Z","caller":"traceutil/trace.go:171","msg":"trace[887388872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"245.512938ms","start":"2026-06-05T11:19:00.390112Z","end":"2026-06-05T11:19:00.635625Z","steps":["trace[887388872] 'agreement among raft nodes before linearized reading' (duration: 245.245561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:19:00.635632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.525361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-05T11:19:00.635663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.531835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-05T11:19:00.635672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.919168ms","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-05T11:19:00.635699Z","caller":"traceutil/trace.go:171","msg":"trace[1944911215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"236.619938ms","start":"2026-06-05T11:19:00.399067Z","end":"2026-06-05T11:19:00.635687Z","steps":["trace[1944911215] 'agreement among raft nodes before linearized reading' (duration: 236.458843ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:00.635768Z","caller":"traceutil/trace.go:171","msg":"trace[1020969758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"237.758376ms","start":"2026-06-05T11:19:00.397926Z","end":"2026-06-05T11:19:00.635684Z","steps":["trace[1020969758] 'agreement among raft nodes before linearized reading' (duration: 237.470639ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:00.635778Z","caller":"traceutil/trace.go:171","msg":"trace[1394713499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"236.055692ms","start":"2026-06-05T11:19:00.399702Z","end":"2026-06-05T11:19:00.635758Z","steps":["trace[1394713499] 'agreement among raft nodes before linearized reading' (duration: 235.775945ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:06.704615Z","caller":"traceutil/trace.go:171","msg":"trace[550721720] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"142.464668ms","start":"2026-06-05T11:19:06.562132Z","end":"2026-06-05T11:19:06.704597Z","steps":["trace[550721720] 'process raft request' (duration: 142.312464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:19:08.623248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.028547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050280"} {"level":"info","ts":"2026-06-05T11:19:08.623329Z","caller":"traceutil/trace.go:171","msg":"trace[1448880590] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:859; }","duration":"104.15008ms","start":"2026-06-05T11:19:08.51916Z","end":"2026-06-05T11:19:08.62331Z","steps":["trace[1448880590] 'range keys from in-memory index tree' (duration: 103.146187ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:35.820486Z","caller":"traceutil/trace.go:171","msg":"trace[618206359] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"117.521104ms","start":"2026-06-05T11:19:35.702939Z","end":"2026-06-05T11:19:35.82046Z","steps":["trace[618206359] 'process raft request' (duration: 117.364631ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:47.302689Z","caller":"traceutil/trace.go:171","msg":"trace[151488147] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"172.466344ms","start":"2026-06-05T11:19:47.130199Z","end":"2026-06-05T11:19:47.302665Z","steps":["trace[151488147] 'process raft request' (duration: 96.374905ms)","trace[151488147] 'compare' (duration: 75.841574ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:19:47.329763Z","caller":"traceutil/trace.go:171","msg":"trace[686126561] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1132; }","duration":"191.654842ms","start":"2026-06-05T11:19:47.138085Z","end":"2026-06-05T11:19:47.32974Z","steps":["trace[686126561] 'read index received' (duration: 88.503292ms)","trace[686126561] 'applied index is now lower than readState.Index' (duration: 103.15066ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:19:47.329788Z","caller":"traceutil/trace.go:171","msg":"trace[322671833] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"199.28067ms","start":"2026-06-05T11:19:47.130477Z","end":"2026-06-05T11:19:47.329757Z","steps":["trace[322671833] 'process raft request' (duration: 199.123357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:19:47.330099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.958577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:1084"} {"level":"info","ts":"2026-06-05T11:19:47.330164Z","caller":"traceutil/trace.go:171","msg":"trace[1923502979] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1094; }","duration":"192.09857ms","start":"2026-06-05T11:19:47.138052Z","end":"2026-06-05T11:19:47.330151Z","steps":["trace[1923502979] 'agreement among raft nodes before linearized reading' (duration: 191.769974ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:19:47.330402Z","caller":"traceutil/trace.go:171","msg":"trace[1253808904] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"199.886761ms","start":"2026-06-05T11:19:47.130487Z","end":"2026-06-05T11:19:47.330374Z","steps":["trace[1253808904] 'process raft request' (duration: 199.221809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:19:57.349451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.182342ms","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-05T11:19:57.349587Z","caller":"traceutil/trace.go:171","msg":"trace[29081795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1123; }","duration":"106.391356ms","start":"2026-06-05T11:19:57.243172Z","end":"2026-06-05T11:19:57.349563Z","steps":["trace[29081795] 'range keys from in-memory index tree' (duration: 105.942989ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:20:48.40389Z","caller":"traceutil/trace.go:171","msg":"trace[150269831] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"110.799447ms","start":"2026-06-05T11:20:48.293064Z","end":"2026-06-05T11:20:48.403863Z","steps":["trace[150269831] 'process raft request' (duration: 110.160589ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:20:55.877552Z","caller":"traceutil/trace.go:171","msg":"trace[446958163] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1409; }","duration":"145.101854ms","start":"2026-06-05T11:20:55.732418Z","end":"2026-06-05T11:20:55.87752Z","steps":["trace[446958163] 'read index received' (duration: 16.252158ms)","trace[446958163] 'applied index is now lower than readState.Index' (duration: 128.848696ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:20:55.877602Z","caller":"traceutil/trace.go:171","msg":"trace[1270654736] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"158.583285ms","start":"2026-06-05T11:20:55.718981Z","end":"2026-06-05T11:20:55.877564Z","steps":["trace[1270654736] 'process raft request' (duration: 135.875581ms)","trace[1270654736] 'compare' (duration: 22.528332ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T11:20:55.877702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.256646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:20:55.877776Z","caller":"traceutil/trace.go:171","msg":"trace[1566110567] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1354; }","duration":"145.374308ms","start":"2026-06-05T11:20:55.732387Z","end":"2026-06-05T11:20:55.877761Z","steps":["trace[1566110567] 'agreement among raft nodes before linearized reading' (duration: 145.249367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:20:56.438642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.282015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-05T11:20:56.438677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.411628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T11:20:56.438788Z","caller":"traceutil/trace.go:171","msg":"trace[1458765058] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1356; }","duration":"268.506078ms","start":"2026-06-05T11:20:56.17026Z","end":"2026-06-05T11:20:56.438766Z","steps":["trace[1458765058] 'count revisions from in-memory index tree' (duration: 268.186124ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T11:20:56.438806Z","caller":"traceutil/trace.go:171","msg":"trace[512947648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1356; }","duration":"396.59912ms","start":"2026-06-05T11:20:56.042181Z","end":"2026-06-05T11:20:56.43878Z","steps":["trace[512947648] 'range keys from in-memory index tree' (duration: 396.307407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:20:56.438856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T11:20:56.042152Z","time spent":"396.689841ms","remote":"127.0.0.1:40968","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-05T11:20:56.438942Z","caller":"traceutil/trace.go:171","msg":"trace[298376994] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"190.569276ms","start":"2026-06-05T11:20:56.24833Z","end":"2026-06-05T11:20:56.438899Z","steps":["trace[298376994] 'read index received' (duration: 183.345889ms)","trace[298376994] 'applied index is now lower than readState.Index' (duration: 7.222427ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T11:20:56.43899Z","caller":"traceutil/trace.go:171","msg":"trace[1613272374] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"211.813521ms","start":"2026-06-05T11:20:56.22715Z","end":"2026-06-05T11:20:56.438964Z","steps":["trace[1613272374] 'process raft request' (duration: 204.514563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T11:20:56.439114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.77491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T11:20:56.439152Z","caller":"traceutil/trace.go:171","msg":"trace[1257179927] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1357; }","duration":"190.87603ms","start":"2026-06-05T11:20:56.248265Z","end":"2026-06-05T11:20:56.439141Z","steps":["trace[1257179927] 'agreement among raft nodes before linearized reading' (duration: 190.744339ms)"],"step_count":1}