{"level":"warn","ts":"2026-05-27T13:36:28.166866Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:36:28.167102Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-05-27T13:36:28.167233Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:36:28.167274Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-27T13:36:28.167326Z","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-05-27T13:36:28.168276Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-27T13:36:28.168417Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-05-27T13:36:28.230717Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"61.964572ms"} {"level":"info","ts":"2026-05-27T13:36:28.438358Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-27T13:36:28.438753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:36:28.438909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-27T13:36:28.43899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:36:28.439067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-27T13:36:28.439182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-27T13:36:28.679076Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:36:28.682767Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:36:28.68614Z","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-05-27T13:36:28.693052Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:36:28.695238Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"warn","ts":"2026-05-27T13:36:28.695318Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"380f6760faea5f9e cannot campaign at term 1 since there are still 1 pending configuration changes to apply"} {"level":"info","ts":"2026-05-27T13:36:28.696492Z","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-05-27T13:36:28.696624Z","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-05-27T13:36:28.696646Z","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-05-27T13:36:28.696881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-27T13:36:28.697997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-27T13:36:28.700484Z","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-05-27T13:36:28.700635Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-27T13:36:28.70071Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-27T13:36:28.70098Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:36:28.701051Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:36:29.660206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:36:29.660289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:36:29.66035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-27T13:36:29.660378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:36:29.660391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-27T13:36:29.66041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-27T13:36:29.660433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-27T13:36:29.661619Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:36:29.661845Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:36:29.661855Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:36:29.661905Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:36:29.66238Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:36:29.662918Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:36:29.664927Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:36:29.665426Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-05-27T13:36:29.674237Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:36:29.67482Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:36:29.67511Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-27T13:36:34.44327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.913344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T13:36:34.443374Z","caller":"traceutil/trace.go:171","msg":"trace[2005752619] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"103.079654ms","start":"2026-05-27T13:36:34.340273Z","end":"2026-05-27T13:36:34.443352Z","steps":["trace[2005752619] 'range keys from in-memory index tree' (duration: 102.767974ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:36:59.468556Z","caller":"traceutil/trace.go:171","msg":"trace[1847009832] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:497; }","duration":"117.205467ms","start":"2026-05-27T13:36:59.351326Z","end":"2026-05-27T13:36:59.468531Z","steps":["trace[1847009832] 'read index received' (duration: 117.046976ms)","trace[1847009832] 'applied index is now lower than readState.Index' (duration: 154.891µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:36:59.468661Z","caller":"traceutil/trace.go:171","msg":"trace[147684334] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"123.821121ms","start":"2026-05-27T13:36:59.34481Z","end":"2026-05-27T13:36:59.468631Z","steps":["trace[147684334] 'process raft request' (duration: 123.560689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:36:59.468732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.393268ms","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-05-27T13:36:59.468815Z","caller":"traceutil/trace.go:171","msg":"trace[17334986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"117.505229ms","start":"2026-05-27T13:36:59.351289Z","end":"2026-05-27T13:36:59.468794Z","steps":["trace[17334986] 'agreement among raft nodes before linearized reading' (duration: 117.370398ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:01.670055Z","caller":"traceutil/trace.go:171","msg":"trace[1510290155] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"168.631795ms","start":"2026-05-27T13:37:01.501404Z","end":"2026-05-27T13:37:01.670036Z","steps":["trace[1510290155] 'read index received' (duration: 168.553605ms)","trace[1510290155] 'applied index is now lower than readState.Index' (duration: 77.33µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:01.670298Z","caller":"traceutil/trace.go:171","msg":"trace[662323551] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"193.375535ms","start":"2026-05-27T13:37:01.47691Z","end":"2026-05-27T13:37:01.670286Z","steps":["trace[662323551] 'process raft request' (duration: 193.019662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:01.670533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.1195ms","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-05-27T13:37:01.670587Z","caller":"traceutil/trace.go:171","msg":"trace[720052827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:484; }","duration":"169.208261ms","start":"2026-05-27T13:37:01.501366Z","end":"2026-05-27T13:37:01.670574Z","steps":["trace[720052827] 'agreement among raft nodes before linearized reading' (duration: 169.11261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:01.726344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.210727ms","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-05-27T13:37:01.72641Z","caller":"traceutil/trace.go:171","msg":"trace[673194225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:485; }","duration":"208.325348ms","start":"2026-05-27T13:37:01.518071Z","end":"2026-05-27T13:37:01.726396Z","steps":["trace[673194225] 'agreement among raft nodes before linearized reading' (duration: 208.210906ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:01.726698Z","caller":"traceutil/trace.go:171","msg":"trace[1319611394] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"103.402497ms","start":"2026-05-27T13:37:01.623284Z","end":"2026-05-27T13:37:01.726686Z","steps":["trace[1319611394] 'process raft request' (duration: 102.909122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:08.256751Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118656527773849,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:37:08.327066Z","caller":"traceutil/trace.go:171","msg":"trace[1413907510] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"631.857519ms","start":"2026-05-27T13:37:07.695182Z","end":"2026-05-27T13:37:08.32704Z","steps":["trace[1413907510] 'process raft request' (duration: 631.648107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:08.327784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:07.695174Z","time spent":"631.96564ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:08.370047Z","caller":"traceutil/trace.go:171","msg":"trace[602834885] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:552; }","duration":"614.324245ms","start":"2026-05-27T13:37:07.755704Z","end":"2026-05-27T13:37:08.370028Z","steps":["trace[602834885] 'read index received' (duration: 571.125053ms)","trace[602834885] 'applied index is now lower than readState.Index' (duration: 43.197302ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:08.37019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.480446ms","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-05-27T13:37:08.370223Z","caller":"traceutil/trace.go:171","msg":"trace[1981640037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"614.548178ms","start":"2026-05-27T13:37:07.755664Z","end":"2026-05-27T13:37:08.370212Z","steps":["trace[1981640037] 'agreement among raft nodes before linearized reading' (duration: 614.475217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:08.370232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.263097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-27T13:37:08.370254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:07.755648Z","time spent":"614.598138ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:37:08.370235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.006917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:08.370281Z","caller":"traceutil/trace.go:171","msg":"trace[1259464930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"602.339907ms","start":"2026-05-27T13:37:07.767926Z","end":"2026-05-27T13:37:08.370266Z","steps":["trace[1259464930] 'agreement among raft nodes before linearized reading' (duration: 602.248376ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:08.370307Z","caller":"traceutil/trace.go:171","msg":"trace[1849317224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"160.115487ms","start":"2026-05-27T13:37:08.210173Z","end":"2026-05-27T13:37:08.370288Z","steps":["trace[1849317224] 'agreement among raft nodes before linearized reading' (duration: 160.000726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:08.370314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:07.767909Z","time spent":"602.397518ms","remote":"127.0.0.1:35358","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-05-27T13:37:08.370412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.275067ms","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-05-27T13:37:08.370437Z","caller":"traceutil/trace.go:171","msg":"trace[779330747] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"600.350307ms","start":"2026-05-27T13:37:07.770078Z","end":"2026-05-27T13:37:08.370429Z","steps":["trace[779330747] 'agreement among raft nodes before linearized reading' (duration: 600.305986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:08.370465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:07.770067Z","time spent":"600.391847ms","remote":"127.0.0.1:35358","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":"info","ts":"2026-05-27T13:37:09.288348Z","caller":"traceutil/trace.go:171","msg":"trace[23979990] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"736.658987ms","start":"2026-05-27T13:37:08.55167Z","end":"2026-05-27T13:37:09.288329Z","steps":["trace[23979990] 'process raft request' (duration: 736.552726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.288455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.551652Z","time spent":"736.752269ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.373524Z","caller":"traceutil/trace.go:171","msg":"trace[1209314542] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"821.510595ms","start":"2026-05-27T13:37:08.551986Z","end":"2026-05-27T13:37:09.373497Z","steps":["trace[1209314542] 'process raft request' (duration: 821.322613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.373641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.551979Z","time spent":"821.603046ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.373736Z","caller":"traceutil/trace.go:171","msg":"trace[576343422] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"800.615918ms","start":"2026-05-27T13:37:08.573115Z","end":"2026-05-27T13:37:09.373731Z","steps":["trace[576343422] 'process raft request' (duration: 800.420346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.373761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.573102Z","time spent":"800.647518ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.373811Z","caller":"traceutil/trace.go:171","msg":"trace[1124440492] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"821.77118ms","start":"2026-05-27T13:37:08.552034Z","end":"2026-05-27T13:37:09.373805Z","steps":["trace[1124440492] 'process raft request' (duration: 821.405685ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:09.373802Z","caller":"traceutil/trace.go:171","msg":"trace[853762134] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"799.087512ms","start":"2026-05-27T13:37:08.574683Z","end":"2026-05-27T13:37:09.373771Z","steps":["trace[853762134] 'process raft request' (duration: 798.901689ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:09.373813Z","caller":"traceutil/trace.go:171","msg":"trace[1036941243] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"797.568915ms","start":"2026-05-27T13:37:08.576225Z","end":"2026-05-27T13:37:09.373794Z","steps":["trace[1036941243] 'process raft request' (duration: 797.417173ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:09.373859Z","caller":"traceutil/trace.go:171","msg":"trace[237785326] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"813.769683ms","start":"2026-05-27T13:37:08.560085Z","end":"2026-05-27T13:37:09.373855Z","steps":["trace[237785326] 'process raft request' (duration: 813.407198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.373881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.560048Z","time spent":"813.824063ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:37:09.373936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.574667Z","time spent":"799.205153ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:37:09.373934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.576211Z","time spent":"797.664186ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.374057Z","caller":"traceutil/trace.go:171","msg":"trace[1433847283] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"797.517145ms","start":"2026-05-27T13:37:08.576527Z","end":"2026-05-27T13:37:09.374044Z","steps":["trace[1433847283] 'process raft request' (duration: 797.15963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.37383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.552029Z","time spent":"821.79103ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:37:09.374107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.576517Z","time spent":"797.565796ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.374805Z","caller":"traceutil/trace.go:171","msg":"trace[1013558672] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"791.038055ms","start":"2026-05-27T13:37:08.583741Z","end":"2026-05-27T13:37:09.374779Z","steps":["trace[1013558672] 'process raft request' (duration: 789.998423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.374889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.583732Z","time spent":"791.121176ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.375189Z","caller":"traceutil/trace.go:171","msg":"trace[1202136118] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:558; }","duration":"164.023286ms","start":"2026-05-27T13:37:09.211154Z","end":"2026-05-27T13:37:09.375178Z","steps":["trace[1202136118] 'read index received' (duration: 77.170133ms)","trace[1202136118] 'applied index is now lower than readState.Index' (duration: 86.852203ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:09.375269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.106467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:09.375299Z","caller":"traceutil/trace.go:171","msg":"trace[2143005258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"164.175797ms","start":"2026-05-27T13:37:09.211113Z","end":"2026-05-27T13:37:09.375289Z","steps":["trace[2143005258] 'agreement among raft nodes before linearized reading' (duration: 164.105146ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:09.375667Z","caller":"traceutil/trace.go:171","msg":"trace[374708162] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"772.28562ms","start":"2026-05-27T13:37:08.603365Z","end":"2026-05-27T13:37:09.375651Z","steps":["trace[374708162] 'process raft request' (duration: 771.665202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.375746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.603352Z","time spent":"772.358902ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.375876Z","caller":"traceutil/trace.go:171","msg":"trace[1429316531] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"773.751466ms","start":"2026-05-27T13:37:08.602116Z","end":"2026-05-27T13:37:09.375867Z","steps":["trace[1429316531] 'process raft request' (duration: 772.472892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.375921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.602102Z","time spent":"773.796327ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.376048Z","caller":"traceutil/trace.go:171","msg":"trace[241627852] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"632.828058ms","start":"2026-05-27T13:37:08.743212Z","end":"2026-05-27T13:37:09.37604Z","steps":["trace[241627852] 'process raft request' (duration: 631.903947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:09.376092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:08.74318Z","time spent":"632.891268ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:09.46075Z","caller":"traceutil/trace.go:171","msg":"trace[390634535] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"168.166421ms","start":"2026-05-27T13:37:09.292548Z","end":"2026-05-27T13:37:09.460714Z","steps":["trace[390634535] 'process raft request' (duration: 147.445589ms)","trace[390634535] 'compare' (duration: 20.434338ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:09.460827Z","caller":"traceutil/trace.go:171","msg":"trace[1557252428] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"167.502084ms","start":"2026-05-27T13:37:09.2933Z","end":"2026-05-27T13:37:09.460802Z","steps":["trace[1557252428] 'process raft request' (duration: 167.321802ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:09.461004Z","caller":"traceutil/trace.go:171","msg":"trace[116299961] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"166.153309ms","start":"2026-05-27T13:37:09.294806Z","end":"2026-05-27T13:37:09.460959Z","steps":["trace[116299961] 'process raft request' (duration: 165.921087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:10.466714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.55313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:37:10.466826Z","caller":"traceutil/trace.go:171","msg":"trace[769959102] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"649.084396ms","start":"2026-05-27T13:37:09.817721Z","end":"2026-05-27T13:37:10.466805Z","steps":["trace[769959102] 'process raft request' (duration: 488.188242ms)","trace[769959102] 'compare' (duration: 160.357408ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:10.466924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:09.817703Z","time spent":"649.152606ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:10.473469Z","caller":"traceutil/trace.go:171","msg":"trace[1582896891] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"139.498699ms","start":"2026-05-27T13:37:10.33395Z","end":"2026-05-27T13:37:10.473448Z","steps":["trace[1582896891] 'read index received' (duration: 139.234596ms)","trace[1582896891] 'applied index is now lower than readState.Index' (duration: 263.493µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:10.473738Z","caller":"traceutil/trace.go:171","msg":"trace[491966074] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"650.642116ms","start":"2026-05-27T13:37:09.823088Z","end":"2026-05-27T13:37:10.473731Z","steps":["trace[491966074] 'process raft request' (duration: 650.159811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:10.473809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:09.823071Z","time spent":"650.691706ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:37:10.474104Z","caller":"traceutil/trace.go:171","msg":"trace[1486406531] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"630.646912ms","start":"2026-05-27T13:37:09.843441Z","end":"2026-05-27T13:37:10.474088Z","steps":["trace[1486406531] 'process raft request' (duration: 629.936804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:10.474197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:09.843422Z","time spent":"630.722883ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:37:10.474323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.37326ms","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-05-27T13:37:10.47434Z","caller":"traceutil/trace.go:171","msg":"trace[761893141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"140.42648ms","start":"2026-05-27T13:37:10.333908Z","end":"2026-05-27T13:37:10.474335Z","steps":["trace[761893141] 'agreement among raft nodes before linearized reading' (duration: 140.381489ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.646041Z","caller":"traceutil/trace.go:171","msg":"trace[1958215571] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"160.669461ms","start":"2026-05-27T13:37:10.485355Z","end":"2026-05-27T13:37:10.646024Z","steps":["trace[1958215571] 'process raft request' (duration: 82.335693ms)","trace[1958215571] 'compare' (duration: 78.206627ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:10.646269Z","caller":"traceutil/trace.go:171","msg":"trace[1231703420] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"160.787582ms","start":"2026-05-27T13:37:10.485476Z","end":"2026-05-27T13:37:10.646263Z","steps":["trace[1231703420] 'process raft request' (duration: 160.524789ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.646472Z","caller":"traceutil/trace.go:171","msg":"trace[1671875018] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"158.496247ms","start":"2026-05-27T13:37:10.48797Z","end":"2026-05-27T13:37:10.646467Z","steps":["trace[1671875018] 'process raft request' (duration: 158.271764ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.646716Z","caller":"traceutil/trace.go:171","msg":"trace[819241196] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"157.261323ms","start":"2026-05-27T13:37:10.48945Z","end":"2026-05-27T13:37:10.646711Z","steps":["trace[819241196] 'process raft request' (duration: 156.995039ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.646978Z","caller":"traceutil/trace.go:171","msg":"trace[1917946010] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"110.386705ms","start":"2026-05-27T13:37:10.536572Z","end":"2026-05-27T13:37:10.646958Z","steps":["trace[1917946010] 'process raft request' (duration: 110.244354ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.64713Z","caller":"traceutil/trace.go:171","msg":"trace[1959358951] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"142.036747ms","start":"2026-05-27T13:37:10.505084Z","end":"2026-05-27T13:37:10.647121Z","steps":["trace[1959358951] 'process raft request' (duration: 141.568142ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:10.859182Z","caller":"traceutil/trace.go:171","msg":"trace[370915091] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"157.18113ms","start":"2026-05-27T13:37:10.701939Z","end":"2026-05-27T13:37:10.85912Z","steps":["trace[370915091] 'process raft request' (duration: 79.863945ms)","trace[370915091] 'compare' (duration: 74.21001ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:11.050752Z","caller":"traceutil/trace.go:171","msg":"trace[1326626526] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"106.937777ms","start":"2026-05-27T13:37:10.943796Z","end":"2026-05-27T13:37:11.050734Z","steps":["trace[1326626526] 'process raft request' (duration: 75.702101ms)","trace[1326626526] 'compare' (duration: 31.126135ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:11.057234Z","caller":"traceutil/trace.go:171","msg":"trace[157676378] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"110.192817ms","start":"2026-05-27T13:37:10.947022Z","end":"2026-05-27T13:37:11.057215Z","steps":["trace[157676378] 'process raft request' (duration: 110.107337ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:11.25698Z","caller":"traceutil/trace.go:171","msg":"trace[374564328] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"105.030841ms","start":"2026-05-27T13:37:11.151919Z","end":"2026-05-27T13:37:11.25695Z","steps":["trace[374564328] 'process raft request' (duration: 36.867072ms)","trace[374564328] 'compare' (duration: 68.029857ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:11.561371Z","caller":"traceutil/trace.go:171","msg":"trace[1671463080] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"121.477844ms","start":"2026-05-27T13:37:11.439858Z","end":"2026-05-27T13:37:11.561336Z","steps":["trace[1671463080] 'read index received' (duration: 86.627605ms)","trace[1671463080] 'applied index is now lower than readState.Index' (duration: 34.848509ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:11.561614Z","caller":"traceutil/trace.go:171","msg":"trace[1530292866] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"173.690326ms","start":"2026-05-27T13:37:11.387851Z","end":"2026-05-27T13:37:11.561541Z","steps":["trace[1530292866] 'process raft request' (duration: 138.539254ms)","trace[1530292866] 'compare' (duration: 34.672997ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:11.561827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.856719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-05-27T13:37:11.561945Z","caller":"traceutil/trace.go:171","msg":"trace[692318692] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:607; }","duration":"122.111432ms","start":"2026-05-27T13:37:11.439811Z","end":"2026-05-27T13:37:11.561922Z","steps":["trace[692318692] 'agreement among raft nodes before linearized reading' (duration: 121.735947ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:11.578492Z","caller":"traceutil/trace.go:171","msg":"trace[768215047] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"124.988166ms","start":"2026-05-27T13:37:11.453469Z","end":"2026-05-27T13:37:11.578457Z","steps":["trace[768215047] 'process raft request' (duration: 124.696452ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:16.393157Z","caller":"traceutil/trace.go:171","msg":"trace[1930038378] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"182.030024ms","start":"2026-05-27T13:37:16.211101Z","end":"2026-05-27T13:37:16.393131Z","steps":["trace[1930038378] 'read index received' (duration: 180.514955ms)","trace[1930038378] 'applied index is now lower than readState.Index' (duration: 1.514199ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:16.394144Z","caller":"traceutil/trace.go:171","msg":"trace[87137554] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"321.070861ms","start":"2026-05-27T13:37:16.073035Z","end":"2026-05-27T13:37:16.394106Z","steps":["trace[87137554] 'process raft request' (duration: 319.337908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:16.394299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.073008Z","time spent":"321.234894ms","remote":"127.0.0.1:35192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:37:16.394481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.356501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:16.394559Z","caller":"traceutil/trace.go:171","msg":"trace[354517732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"183.464253ms","start":"2026-05-27T13:37:16.211067Z","end":"2026-05-27T13:37:16.394532Z","steps":["trace[354517732] 'agreement among raft nodes before linearized reading' (duration: 183.126359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.283765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.843909ms","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-05-27T13:37:17.283874Z","caller":"traceutil/trace.go:171","msg":"trace[715790468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"599.95722ms","start":"2026-05-27T13:37:16.683861Z","end":"2026-05-27T13:37:17.283818Z","steps":["trace[715790468] 'range keys from in-memory index tree' (duration: 599.705597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.283914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.683838Z","time spent":"600.067571ms","remote":"127.0.0.1:35358","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-05-27T13:37:17.283879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.395292ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:37:17.283979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.824809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-27T13:37:17.283978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.874844ms","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-05-27T13:37:17.284034Z","caller":"traceutil/trace.go:171","msg":"trace[1252568803] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:635; }","duration":"197.601574ms","start":"2026-05-27T13:37:17.086407Z","end":"2026-05-27T13:37:17.284009Z","steps":["trace[1252568803] 'range keys from in-memory index tree' (duration: 197.369221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.284051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.379886ms","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-05-27T13:37:17.28406Z","caller":"traceutil/trace.go:171","msg":"trace[1873850793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"599.9436ms","start":"2026-05-27T13:37:16.684095Z","end":"2026-05-27T13:37:17.284039Z","steps":["trace[1873850793] 'range keys from in-memory index tree' (duration: 599.654056ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:17.284102Z","caller":"traceutil/trace.go:171","msg":"trace[1800241958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"610.427936ms","start":"2026-05-27T13:37:16.673655Z","end":"2026-05-27T13:37:17.284083Z","steps":["trace[1800241958] 'range keys from in-memory index tree' (duration: 610.246015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.284105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.68409Z","time spent":"600.00651ms","remote":"127.0.0.1:35358","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-05-27T13:37:17.284113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.287178ms","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-05-27T13:37:17.284135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.673595Z","time spent":"610.531918ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:37:17.284147Z","caller":"traceutil/trace.go:171","msg":"trace[2093998237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"608.372729ms","start":"2026-05-27T13:37:16.675763Z","end":"2026-05-27T13:37:17.284136Z","steps":["trace[2093998237] 'range keys from in-memory index tree' (duration: 608.103386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.284174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.675735Z","time spent":"608.43297ms","remote":"127.0.0.1:35358","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":"info","ts":"2026-05-27T13:37:17.284063Z","caller":"traceutil/trace.go:171","msg":"trace[417551817] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:635; }","duration":"829.006206ms","start":"2026-05-27T13:37:16.455035Z","end":"2026-05-27T13:37:17.284041Z","steps":["trace[417551817] 'range keys from in-memory index tree' (duration: 828.695102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:17.284247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:16.455016Z","time spent":"829.224218ms","remote":"127.0.0.1:35270","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-05-27T13:37:17.434747Z","caller":"traceutil/trace.go:171","msg":"trace[370363899] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"146.130104ms","start":"2026-05-27T13:37:17.288594Z","end":"2026-05-27T13:37:17.434724Z","steps":["trace[370363899] 'process raft request' (duration: 145.960842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:18.66492Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.229712317s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T13:37:19.402565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.328014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:37:19.403429Z","caller":"traceutil/trace.go:171","msg":"trace[896911413] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"2.114137158s","start":"2026-05-27T13:37:17.289261Z","end":"2026-05-27T13:37:19.403398Z","steps":["trace[896911413] 'process raft request' (duration: 1.375839071s)","trace[896911413] 'compare' (duration: 737.157822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:19.40359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:17.289239Z","time spent":"2.11426193s","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:19.403603Z","caller":"traceutil/trace.go:171","msg":"trace[1782661084] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"2.11424059s","start":"2026-05-27T13:37:17.289353Z","end":"2026-05-27T13:37:19.403593Z","steps":["trace[1782661084] 'process raft request' (duration: 2.113852915s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:19.40368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:17.289347Z","time spent":"2.114310851s","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:19.403445Z","caller":"traceutil/trace.go:171","msg":"trace[1650830765] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"2.113584962s","start":"2026-05-27T13:37:17.289837Z","end":"2026-05-27T13:37:19.403422Z","steps":["trace[1650830765] 'process raft request' (duration: 2.113507121s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:19.403924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:17.28983Z","time spent":"2.113895216s","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:19.405773Z","caller":"traceutil/trace.go:171","msg":"trace[644320478] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.714718725s","start":"2026-05-27T13:37:17.691035Z","end":"2026-05-27T13:37:19.405753Z","steps":["trace[644320478] 'process raft request' (duration: 1.714250318s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:19.405846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:17.691003Z","time spent":"1.714808876s","remote":"127.0.0.1:35192","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-05-27T13:37:19.419174Z","caller":"traceutil/trace.go:171","msg":"trace[1932801680] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:661; }","duration":"1.208736117s","start":"2026-05-27T13:37:18.210422Z","end":"2026-05-27T13:37:19.419158Z","steps":["trace[1932801680] 'read index received' (duration: 454.802216ms)","trace[1932801680] 'applied index is now lower than readState.Index' (duration: 753.932701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:19.41939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.20896642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:19.419556Z","caller":"traceutil/trace.go:171","msg":"trace[236789233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"1.209147512s","start":"2026-05-27T13:37:18.210365Z","end":"2026-05-27T13:37:19.419513Z","steps":["trace[236789233] 'agreement among raft nodes before linearized reading' (duration: 1.20898157s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:19.419674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:18.210343Z","time spent":"1.209321146s","remote":"127.0.0.1:35100","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-05-27T13:37:19.929534Z","caller":"traceutil/trace.go:171","msg":"trace[1537508256] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"100.643539ms","start":"2026-05-27T13:37:19.828864Z","end":"2026-05-27T13:37:19.929507Z","steps":["trace[1537508256] 'process raft request' (duration: 100.460987ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:20.194534Z","caller":"traceutil/trace.go:171","msg":"trace[1305553167] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"355.280013ms","start":"2026-05-27T13:37:19.839219Z","end":"2026-05-27T13:37:20.194499Z","steps":["trace[1305553167] 'process raft request' (duration: 354.925408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:20.194736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:19.839194Z","time spent":"355.452855ms","remote":"127.0.0.1:35258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17232,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:20.196028Z","caller":"traceutil/trace.go:171","msg":"trace[1527229265] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"285.503156ms","start":"2026-05-27T13:37:19.90995Z","end":"2026-05-27T13:37:20.195453Z","steps":["trace[1527229265] 'process raft request' (duration: 284.585413ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:21.324731Z","caller":"traceutil/trace.go:171","msg":"trace[890345198] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"112.795957ms","start":"2026-05-27T13:37:21.211888Z","end":"2026-05-27T13:37:21.324684Z","steps":["trace[890345198] 'read index received' (duration: 110.731348ms)","trace[890345198] 'applied index is now lower than readState.Index' (duration: 2.063239ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:21.32482Z","caller":"traceutil/trace.go:171","msg":"trace[1175218608] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"133.933746ms","start":"2026-05-27T13:37:21.190847Z","end":"2026-05-27T13:37:21.324781Z","steps":["trace[1175218608] 'process raft request' (duration: 132.09864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:21.324937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.022309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:21.325021Z","caller":"traceutil/trace.go:171","msg":"trace[1677576768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"113.153522ms","start":"2026-05-27T13:37:21.211849Z","end":"2026-05-27T13:37:21.325003Z","steps":["trace[1677576768] 'agreement among raft nodes before linearized reading' (duration: 112.99234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:22.63327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.931942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:37:22.633398Z","caller":"traceutil/trace.go:171","msg":"trace[2094954926] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"274.972386ms","start":"2026-05-27T13:37:22.358406Z","end":"2026-05-27T13:37:22.633378Z","steps":["trace[2094954926] 'process raft request' (duration: 166.838311ms)","trace[2094954926] 'compare' (duration: 107.76089ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:22.635117Z","caller":"traceutil/trace.go:171","msg":"trace[405719625] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"276.421875ms","start":"2026-05-27T13:37:22.358678Z","end":"2026-05-27T13:37:22.6351Z","steps":["trace[405719625] 'process raft request' (duration: 276.355524ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:22.696803Z","caller":"traceutil/trace.go:171","msg":"trace[1434504460] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"137.536397ms","start":"2026-05-27T13:37:22.559253Z","end":"2026-05-27T13:37:22.696789Z","steps":["trace[1434504460] 'process raft request' (duration: 137.477097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:22.924756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.820042ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:37:22.924959Z","caller":"traceutil/trace.go:171","msg":"trace[368490715] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"197.239527ms","start":"2026-05-27T13:37:22.727698Z","end":"2026-05-27T13:37:22.924938Z","steps":["trace[368490715] 'process raft request' (duration: 66.132241ms)","trace[368490715] 'compare' (duration: 130.209723ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:22.927282Z","caller":"traceutil/trace.go:171","msg":"trace[504026337] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"199.371168ms","start":"2026-05-27T13:37:22.727886Z","end":"2026-05-27T13:37:22.927257Z","steps":["trace[504026337] 'process raft request' (duration: 199.210106ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:22.928016Z","caller":"traceutil/trace.go:171","msg":"trace[1826704465] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"199.52172ms","start":"2026-05-27T13:37:22.728367Z","end":"2026-05-27T13:37:22.927889Z","steps":["trace[1826704465] 'process raft request' (duration: 198.84034ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:22.927505Z","caller":"traceutil/trace.go:171","msg":"trace[614601378] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"169.894893ms","start":"2026-05-27T13:37:22.757599Z","end":"2026-05-27T13:37:22.927494Z","steps":["trace[614601378] 'process raft request' (duration: 169.856253ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:23.123845Z","caller":"traceutil/trace.go:171","msg":"trace[878485293] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"161.534449ms","start":"2026-05-27T13:37:22.962293Z","end":"2026-05-27T13:37:23.123828Z","steps":["trace[878485293] 'process raft request' (duration: 161.510279ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:23.124191Z","caller":"traceutil/trace.go:171","msg":"trace[574563871] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"181.510267ms","start":"2026-05-27T13:37:22.942642Z","end":"2026-05-27T13:37:23.124153Z","steps":["trace[574563871] 'process raft request' (duration: 181.120351ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:23.124317Z","caller":"traceutil/trace.go:171","msg":"trace[1330349441] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"184.640282ms","start":"2026-05-27T13:37:22.939306Z","end":"2026-05-27T13:37:23.123947Z","steps":["trace[1330349441] 'process raft request' (duration: 184.360038ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:23.282885Z","caller":"traceutil/trace.go:171","msg":"trace[1614038119] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"153.123777ms","start":"2026-05-27T13:37:23.129734Z","end":"2026-05-27T13:37:23.282857Z","steps":["trace[1614038119] 'process raft request' (duration: 118.44251ms)","trace[1614038119] 'compare' (duration: 34.455544ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:37:23.283128Z","caller":"traceutil/trace.go:171","msg":"trace[778051754] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"148.923615ms","start":"2026-05-27T13:37:23.134185Z","end":"2026-05-27T13:37:23.283109Z","steps":["trace[778051754] 'process raft request' (duration: 148.60124ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:23.283443Z","caller":"traceutil/trace.go:171","msg":"trace[115791629] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"122.848574ms","start":"2026-05-27T13:37:23.160584Z","end":"2026-05-27T13:37:23.283432Z","steps":["trace[115791629] 'process raft request' (duration: 122.453499ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:35.311742Z","caller":"traceutil/trace.go:171","msg":"trace[744646671] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"100.164773ms","start":"2026-05-27T13:37:35.211552Z","end":"2026-05-27T13:37:35.311717Z","steps":["trace[744646671] 'read index received' (duration: 99.899388ms)","trace[744646671] 'applied index is now lower than readState.Index' (duration: 264.405µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:35.311924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.376245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:35.311819Z","caller":"traceutil/trace.go:171","msg":"trace[827224717] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"352.208166ms","start":"2026-05-27T13:37:34.959568Z","end":"2026-05-27T13:37:35.311776Z","steps":["trace[827224717] 'process raft request' (duration: 351.946101ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:35.31202Z","caller":"traceutil/trace.go:171","msg":"trace[786720233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"100.537138ms","start":"2026-05-27T13:37:35.211458Z","end":"2026-05-27T13:37:35.311995Z","steps":["trace[786720233] 'agreement among raft nodes before linearized reading' (duration: 100.375766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:35.312371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:37:34.959547Z","time spent":"352.623863ms","remote":"127.0.0.1:35318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:37:37.831906Z","caller":"traceutil/trace.go:171","msg":"trace[2069387838] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"106.197712ms","start":"2026-05-27T13:37:37.725693Z","end":"2026-05-27T13:37:37.83189Z","steps":["trace[2069387838] 'process raft request' (duration: 106.108211ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:37.833916Z","caller":"traceutil/trace.go:171","msg":"trace[338328751] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"108.161686ms","start":"2026-05-27T13:37:37.725735Z","end":"2026-05-27T13:37:37.833897Z","steps":["trace[338328751] 'process raft request' (duration: 107.948192ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:37.834008Z","caller":"traceutil/trace.go:171","msg":"trace[2047665657] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"107.054816ms","start":"2026-05-27T13:37:37.726935Z","end":"2026-05-27T13:37:37.83399Z","steps":["trace[2047665657] 'process raft request' (duration: 106.881563ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:37.833951Z","caller":"traceutil/trace.go:171","msg":"trace[1608877703] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"108.151735ms","start":"2026-05-27T13:37:37.725776Z","end":"2026-05-27T13:37:37.833928Z","steps":["trace[1608877703] 'process raft request' (duration: 108.006603ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:37:37.846588Z","caller":"traceutil/trace.go:171","msg":"trace[2055610664] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:857; }","duration":"111.382181ms","start":"2026-05-27T13:37:37.735184Z","end":"2026-05-27T13:37:37.846567Z","steps":["trace[2055610664] 'read index received' (duration: 96.756498ms)","trace[2055610664] 'applied index is now lower than readState.Index' (duration: 14.624453ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:37:37.846752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.544984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:37.846793Z","caller":"traceutil/trace.go:171","msg":"trace[977872448] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:829; }","duration":"111.602326ms","start":"2026-05-27T13:37:37.73518Z","end":"2026-05-27T13:37:37.846782Z","steps":["trace[977872448] 'agreement among raft nodes before linearized reading' (duration: 111.523064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:37:37.846937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.699497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:37:37.846977Z","caller":"traceutil/trace.go:171","msg":"trace[140396378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:829; }","duration":"111.763678ms","start":"2026-05-27T13:37:37.735204Z","end":"2026-05-27T13:37:37.846967Z","steps":["trace[140396378] 'agreement among raft nodes before linearized reading' (duration: 111.687857ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:38:08.096634Z","caller":"traceutil/trace.go:171","msg":"trace[1584304216] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"106.061153ms","start":"2026-05-27T13:38:07.990552Z","end":"2026-05-27T13:38:08.096614Z","steps":["trace[1584304216] 'process raft request' (duration: 105.493701ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:38:08.394057Z","caller":"traceutil/trace.go:171","msg":"trace[1418144476] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"145.951767ms","start":"2026-05-27T13:38:08.248062Z","end":"2026-05-27T13:38:08.394013Z","steps":["trace[1418144476] 'process raft request' (duration: 137.484284ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:38:20.497049Z","caller":"traceutil/trace.go:171","msg":"trace[1655496392] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"394.17192ms","start":"2026-05-27T13:38:20.102855Z","end":"2026-05-27T13:38:20.497027Z","steps":["trace[1655496392] 'read index received' (duration: 393.939505ms)","trace[1655496392] 'applied index is now lower than readState.Index' (duration: 231.465µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:38:20.497173Z","caller":"traceutil/trace.go:171","msg":"trace[1884065418] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"458.361174ms","start":"2026-05-27T13:38:20.0388Z","end":"2026-05-27T13:38:20.497161Z","steps":["trace[1884065418] 'process raft request' (duration: 458.063767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:20.497289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.038786Z","time spent":"458.416716ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:38:20.49738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.497117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-27T13:38:20.49749Z","caller":"traceutil/trace.go:171","msg":"trace[1618401040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1097; }","duration":"394.63846ms","start":"2026-05-27T13:38:20.102825Z","end":"2026-05-27T13:38:20.497463Z","steps":["trace[1618401040] 'agreement among raft nodes before linearized reading' (duration: 394.356594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:20.497579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.102812Z","time spent":"394.752104ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:38:21.021102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.967982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:38:21.021168Z","caller":"traceutil/trace.go:171","msg":"trace[1506007357] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"524.022524ms","start":"2026-05-27T13:38:20.497134Z","end":"2026-05-27T13:38:21.021157Z","steps":["trace[1506007357] 'read index received' (duration: 374.050691ms)","trace[1506007357] 'applied index is now lower than readState.Index' (duration: 149.971233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:38:21.021295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.833313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T13:38:21.021312Z","caller":"traceutil/trace.go:171","msg":"trace[978516977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1098; }","duration":"859.881895ms","start":"2026-05-27T13:38:20.161425Z","end":"2026-05-27T13:38:21.021307Z","steps":["trace[978516977] 'agreement among raft nodes before linearized reading' (duration: 859.775152ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:21.021292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.995799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:38:21.021329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.161401Z","time spent":"859.923916ms","remote":"127.0.0.1:35358","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-05-27T13:38:21.02136Z","caller":"traceutil/trace.go:171","msg":"trace[691410294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1098; }","duration":"811.107223ms","start":"2026-05-27T13:38:20.210234Z","end":"2026-05-27T13:38:21.021341Z","steps":["trace[691410294] 'agreement among raft nodes before linearized reading' (duration: 810.929058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:21.021407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.210212Z","time spent":"811.187394ms","remote":"127.0.0.1:35094","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-05-27T13:38:21.021487Z","caller":"traceutil/trace.go:171","msg":"trace[870000988] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"844.598666ms","start":"2026-05-27T13:38:20.176881Z","end":"2026-05-27T13:38:21.02148Z","steps":["trace[870000988] 'process raft request' (duration: 694.190983ms)","trace[870000988] 'compare' (duration: 149.767318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:38:21.021521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.176856Z","time spent":"844.649297ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:38:21.021807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.317892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T13:38:21.021872Z","caller":"traceutil/trace.go:171","msg":"trace[374356729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1098; }","duration":"884.380943ms","start":"2026-05-27T13:38:20.137471Z","end":"2026-05-27T13:38:21.021852Z","steps":["trace[374356729] 'agreement among raft nodes before linearized reading' (duration: 883.730908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:21.022034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.137441Z","time spent":"884.575878ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T13:38:21.028223Z","caller":"traceutil/trace.go:171","msg":"trace[1788449291] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"526.439099ms","start":"2026-05-27T13:38:20.50177Z","end":"2026-05-27T13:38:21.028209Z","steps":["trace[1788449291] 'process raft request' (duration: 526.267085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:21.028291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.501749Z","time spent":"526.507881ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:38:21.028275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.890062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:38:21.028424Z","caller":"traceutil/trace.go:171","msg":"trace[1339141603] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1099; }","duration":"471.078168ms","start":"2026-05-27T13:38:20.557334Z","end":"2026-05-27T13:38:21.028412Z","steps":["trace[1339141603] 'agreement among raft nodes before linearized reading' (duration: 470.892382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:38:21.028461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:38:20.557315Z","time spent":"471.134258ms","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-05-27T13:39:23.495083Z","caller":"traceutil/trace.go:171","msg":"trace[1045696654] linearizableReadLoop","detail":"{readStateIndex:1393; appliedIndex:1392; }","duration":"149.775528ms","start":"2026-05-27T13:39:23.34528Z","end":"2026-05-27T13:39:23.495055Z","steps":["trace[1045696654] 'read index received' (duration: 149.564342ms)","trace[1045696654] 'applied index is now lower than readState.Index' (duration: 210.266µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:39:23.495183Z","caller":"traceutil/trace.go:171","msg":"trace[1166677688] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"161.889546ms","start":"2026-05-27T13:39:23.333259Z","end":"2026-05-27T13:39:23.495148Z","steps":["trace[1166677688] 'process raft request' (duration: 161.64347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:39:23.495339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.029654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-05-27T13:39:23.49538Z","caller":"traceutil/trace.go:171","msg":"trace[1545909636] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1338; }","duration":"150.107617ms","start":"2026-05-27T13:39:23.345261Z","end":"2026-05-27T13:39:23.495369Z","steps":["trace[1545909636] 'agreement among raft nodes before linearized reading' (duration: 149.933492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:39:23.495976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.435122ms","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-05-27T13:39:23.496225Z","caller":"traceutil/trace.go:171","msg":"trace[2050866521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1338; }","duration":"143.743039ms","start":"2026-05-27T13:39:23.352466Z","end":"2026-05-27T13:39:23.496209Z","steps":["trace[2050866521] 'agreement among raft nodes before linearized reading' (duration: 142.854946ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:39:26.732033Z","caller":"traceutil/trace.go:171","msg":"trace[2140288658] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"373.196154ms","start":"2026-05-27T13:39:26.35881Z","end":"2026-05-27T13:39:26.732007Z","steps":["trace[2140288658] 'process raft request' (duration: 373.05111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:39:26.732187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:39:26.358787Z","time spent":"373.323277ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:39:59.360546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.620744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:483"} {"level":"warn","ts":"2026-05-27T13:39:59.360665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.40883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-05-27T13:39:59.360809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.90916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-27T13:39:59.360894Z","caller":"traceutil/trace.go:171","msg":"trace[16574130] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1461; }","duration":"199.756947ms","start":"2026-05-27T13:39:59.160864Z","end":"2026-05-27T13:39:59.360621Z","steps":["trace[16574130] 'range keys from in-memory index tree' (duration: 199.536002ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:39:59.360934Z","caller":"traceutil/trace.go:171","msg":"trace[1383427891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1461; }","duration":"171.118656ms","start":"2026-05-27T13:39:59.189795Z","end":"2026-05-27T13:39:59.360914Z","steps":["trace[1383427891] 'range keys from in-memory index tree' (duration: 170.741516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:39:59.360554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.88217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:39:59.361142Z","caller":"traceutil/trace.go:171","msg":"trace[58018885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1461; }","duration":"149.451425ms","start":"2026-05-27T13:39:59.211607Z","end":"2026-05-27T13:39:59.361058Z","steps":["trace[58018885] 'range keys from in-memory index tree' (duration: 148.795228ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:39:59.361291Z","caller":"traceutil/trace.go:171","msg":"trace[940913807] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:1461; }","duration":"202.479291ms","start":"2026-05-27T13:39:59.15822Z","end":"2026-05-27T13:39:59.3607Z","steps":["trace[940913807] 'range keys from in-memory index tree' (duration: 202.296166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.005154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.430899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:808"} {"level":"info","ts":"2026-05-27T13:40:00.00524Z","caller":"traceutil/trace.go:171","msg":"trace[1897433809] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:1464; }","duration":"308.551562ms","start":"2026-05-27T13:39:59.696668Z","end":"2026-05-27T13:40:00.00522Z","steps":["trace[1897433809] 'agreement among raft nodes before linearized reading' (duration: 308.385898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.005282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:39:59.696653Z","time spent":"308.619633ms","remote":"127.0.0.1:35416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":831,"request content":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:40:00.005457Z","caller":"traceutil/trace.go:171","msg":"trace[1330458149] linearizableReadLoop","detail":"{readStateIndex:1526; appliedIndex:1525; }","duration":"308.141671ms","start":"2026-05-27T13:39:59.696706Z","end":"2026-05-27T13:40:00.004848Z","steps":["trace[1330458149] 'read index received' (duration: 307.964276ms)","trace[1330458149] 'applied index is now lower than readState.Index' (duration: 176.255µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:40:00.005007Z","caller":"traceutil/trace.go:171","msg":"trace[1145019433] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"377.075251ms","start":"2026-05-27T13:39:59.627907Z","end":"2026-05-27T13:40:00.004982Z","steps":["trace[1145019433] 'process raft request' (duration: 376.799433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.005654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:39:59.627894Z","time spent":"377.686267ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:40:00.005698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.254755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:853"} {"level":"info","ts":"2026-05-27T13:40:00.005744Z","caller":"traceutil/trace.go:171","msg":"trace[1704758604] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1464; }","duration":"304.343388ms","start":"2026-05-27T13:39:59.701386Z","end":"2026-05-27T13:40:00.00573Z","steps":["trace[1704758604] 'agreement among raft nodes before linearized reading' (duration: 304.227514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.005786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:39:59.701371Z","time spent":"304.407719ms","remote":"127.0.0.1:35416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":876,"request content":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:40:00.005844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.467714ms","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-05-27T13:40:00.005894Z","caller":"traceutil/trace.go:171","msg":"trace[1281086149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1464; }","duration":"230.543116ms","start":"2026-05-27T13:39:59.775339Z","end":"2026-05-27T13:40:00.005882Z","steps":["trace[1281086149] 'agreement among raft nodes before linearized reading' (duration: 230.38644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.00596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.722321ms","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-05-27T13:40:00.005994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.184878ms","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-05-27T13:40:00.006034Z","caller":"traceutil/trace.go:171","msg":"trace[1826458827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1464; }","duration":"284.240939ms","start":"2026-05-27T13:39:59.72178Z","end":"2026-05-27T13:40:00.006021Z","steps":["trace[1826458827] 'agreement among raft nodes before linearized reading' (duration: 284.114756ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:00.006009Z","caller":"traceutil/trace.go:171","msg":"trace[401684678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1464; }","duration":"230.828464ms","start":"2026-05-27T13:39:59.775168Z","end":"2026-05-27T13:40:00.005996Z","steps":["trace[401684678] 'agreement among raft nodes before linearized reading' (duration: 230.629908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.221846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.845295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:853"} {"level":"info","ts":"2026-05-27T13:40:00.221932Z","caller":"traceutil/trace.go:171","msg":"trace[2077254401] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1467; }","duration":"143.966948ms","start":"2026-05-27T13:40:00.077946Z","end":"2026-05-27T13:40:00.221913Z","steps":["trace[2077254401] 'range keys from in-memory index tree' (duration: 143.761612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:00.221916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.837212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:808"} {"level":"info","ts":"2026-05-27T13:40:00.222133Z","caller":"traceutil/trace.go:171","msg":"trace[818328495] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:1467; }","duration":"145.076618ms","start":"2026-05-27T13:40:00.077025Z","end":"2026-05-27T13:40:00.222101Z","steps":["trace[818328495] 'range keys from in-memory index tree' (duration: 144.76293ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:01.171082Z","caller":"traceutil/trace.go:171","msg":"trace[164956666] linearizableReadLoop","detail":"{readStateIndex:1530; appliedIndex:1529; }","duration":"115.045801ms","start":"2026-05-27T13:40:01.056016Z","end":"2026-05-27T13:40:01.171062Z","steps":["trace[164956666] 'read index received' (duration: 114.825695ms)","trace[164956666] 'applied index is now lower than readState.Index' (duration: 219.266µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:40:01.171136Z","caller":"traceutil/trace.go:171","msg":"trace[957708539] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"158.114317ms","start":"2026-05-27T13:40:01.013Z","end":"2026-05-27T13:40:01.171114Z","steps":["trace[957708539] 'process raft request' (duration: 157.941783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:01.171248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.210595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:661"} {"level":"info","ts":"2026-05-27T13:40:01.171303Z","caller":"traceutil/trace.go:171","msg":"trace[671537681] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:1468; }","duration":"115.274367ms","start":"2026-05-27T13:40:01.056011Z","end":"2026-05-27T13:40:01.171285Z","steps":["trace[671537681] 'agreement among raft nodes before linearized reading' (duration: 115.168334ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:01.539943Z","caller":"traceutil/trace.go:171","msg":"trace[810384253] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1530; }","duration":"114.874867ms","start":"2026-05-27T13:40:01.425034Z","end":"2026-05-27T13:40:01.539909Z","steps":["trace[810384253] 'read index received' (duration: 114.668231ms)","trace[810384253] 'applied index is now lower than readState.Index' (duration: 205.286µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:40:01.540055Z","caller":"traceutil/trace.go:171","msg":"trace[1563573311] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"117.319004ms","start":"2026-05-27T13:40:01.422697Z","end":"2026-05-27T13:40:01.540016Z","steps":["trace[1563573311] 'process raft request' (duration: 117.005866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:01.540277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.124193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:625"} {"level":"info","ts":"2026-05-27T13:40:01.540336Z","caller":"traceutil/trace.go:171","msg":"trace[116483168] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1469; }","duration":"115.323979ms","start":"2026-05-27T13:40:01.424992Z","end":"2026-05-27T13:40:01.540316Z","steps":["trace[116483168] 'agreement among raft nodes before linearized reading' (duration: 115.109503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:01.540339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.788248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:1 size:670"} {"level":"info","ts":"2026-05-27T13:40:01.540432Z","caller":"traceutil/trace.go:171","msg":"trace[1964923152] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:token-cleaner; range_end:; response_count:1; response_revision:1469; }","duration":"101.924903ms","start":"2026-05-27T13:40:01.438473Z","end":"2026-05-27T13:40:01.540398Z","steps":["trace[1964923152] 'agreement among raft nodes before linearized reading' (duration: 101.742867ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:01.698975Z","caller":"traceutil/trace.go:171","msg":"trace[647234209] linearizableReadLoop","detail":"{readStateIndex:1532; appliedIndex:1531; }","duration":"153.690906ms","start":"2026-05-27T13:40:01.545261Z","end":"2026-05-27T13:40:01.698951Z","steps":["trace[647234209] 'read index received' (duration: 150.429527ms)","trace[647234209] 'applied index is now lower than readState.Index' (duration: 3.260589ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:40:01.699129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.85448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:625"} {"level":"info","ts":"2026-05-27T13:40:01.699117Z","caller":"traceutil/trace.go:171","msg":"trace[1686848992] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"154.458277ms","start":"2026-05-27T13:40:01.544622Z","end":"2026-05-27T13:40:01.69908Z","steps":["trace[1686848992] 'process raft request' (duration: 150.997112ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:01.699162Z","caller":"traceutil/trace.go:171","msg":"trace[718763508] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1470; }","duration":"153.943973ms","start":"2026-05-27T13:40:01.545207Z","end":"2026-05-27T13:40:01.699151Z","steps":["trace[718763508] 'agreement among raft nodes before linearized reading' (duration: 153.870421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:01.69931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.701096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:1 size:670"} {"level":"info","ts":"2026-05-27T13:40:01.699391Z","caller":"traceutil/trace.go:171","msg":"trace[417501380] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:token-cleaner; range_end:; response_count:1; response_revision:1470; }","duration":"153.843771ms","start":"2026-05-27T13:40:01.545529Z","end":"2026-05-27T13:40:01.699373Z","steps":["trace[417501380] 'agreement among raft nodes before linearized reading' (duration: 153.670416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:02.028037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.636445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-05-27T13:40:02.028097Z","caller":"traceutil/trace.go:171","msg":"trace[787708024] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1470; }","duration":"179.729018ms","start":"2026-05-27T13:40:01.848352Z","end":"2026-05-27T13:40:02.028081Z","steps":["trace[787708024] 'range keys from in-memory index tree' (duration: 179.552412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:02.028297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.331777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-kg893c\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-05-27T13:40:02.028372Z","caller":"traceutil/trace.go:171","msg":"trace[1565352768] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-kg893c; range_end:; response_count:1; response_revision:1470; }","duration":"175.4503ms","start":"2026-05-27T13:40:01.852905Z","end":"2026-05-27T13:40:02.028356Z","steps":["trace[1565352768] 'range keys from in-memory index tree' (duration: 175.229525ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:03.910344Z","caller":"traceutil/trace.go:171","msg":"trace[128777977] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"189.692725ms","start":"2026-05-27T13:40:03.720635Z","end":"2026-05-27T13:40:03.910328Z","steps":["trace[128777977] 'read index received' (duration: 167.750975ms)","trace[128777977] 'applied index is now lower than readState.Index' (duration: 21.94097ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:40:03.910521Z","caller":"traceutil/trace.go:171","msg":"trace[583320304] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"205.736324ms","start":"2026-05-27T13:40:03.704776Z","end":"2026-05-27T13:40:03.910512Z","steps":["trace[583320304] 'process raft request' (duration: 183.675402ms)","trace[583320304] 'compare' (duration: 21.637641ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:40:03.910692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.049235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-27T13:40:03.910727Z","caller":"traceutil/trace.go:171","msg":"trace[999242584] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:1477; }","duration":"190.095746ms","start":"2026-05-27T13:40:03.720625Z","end":"2026-05-27T13:40:03.91072Z","steps":["trace[999242584] 'agreement among raft nodes before linearized reading' (duration: 190.027814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:03.910842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.745413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-27T13:40:03.910866Z","caller":"traceutil/trace.go:171","msg":"trace[958280033] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:1477; }","duration":"187.792795ms","start":"2026-05-27T13:40:03.723068Z","end":"2026-05-27T13:40:03.91086Z","steps":["trace[958280033] 'agreement among raft nodes before linearized reading' (duration: 187.751163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:04.146536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.30012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-05-27T13:40:04.14672Z","caller":"traceutil/trace.go:171","msg":"trace[695559594] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1477; }","duration":"105.519366ms","start":"2026-05-27T13:40:04.041174Z","end":"2026-05-27T13:40:04.146693Z","steps":["trace[695559594] 'range keys from in-memory index tree' (duration: 105.196868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:04.147556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.231474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64598"} {"level":"info","ts":"2026-05-27T13:40:04.14761Z","caller":"traceutil/trace.go:171","msg":"trace[1292580504] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1477; }","duration":"118.316907ms","start":"2026-05-27T13:40:04.029279Z","end":"2026-05-27T13:40:04.147596Z","steps":["trace[1292580504] 'range keys from in-memory index tree' (duration: 117.834074ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:07.320015Z","caller":"traceutil/trace.go:171","msg":"trace[1188586698] linearizableReadLoop","detail":"{readStateIndex:1551; appliedIndex:1550; }","duration":"109.768088ms","start":"2026-05-27T13:40:07.210222Z","end":"2026-05-27T13:40:07.31999Z","steps":["trace[1188586698] 'read index received' (duration: 109.609364ms)","trace[1188586698] 'applied index is now lower than readState.Index' (duration: 157.904µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:40:07.320072Z","caller":"traceutil/trace.go:171","msg":"trace[2073131555] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"117.601663ms","start":"2026-05-27T13:40:07.202443Z","end":"2026-05-27T13:40:07.320044Z","steps":["trace[2073131555] 'process raft request' (duration: 117.387408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:07.320152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.903652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:40:07.32021Z","caller":"traceutil/trace.go:171","msg":"trace[1665796246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1488; }","duration":"109.999955ms","start":"2026-05-27T13:40:07.210194Z","end":"2026-05-27T13:40:07.320194Z","steps":["trace[1665796246] 'agreement among raft nodes before linearized reading' (duration: 109.895742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:08.212076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.322538ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-27T13:40:08.212583Z","caller":"traceutil/trace.go:171","msg":"trace[1685344904] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"248.311518ms","start":"2026-05-27T13:40:07.964245Z","end":"2026-05-27T13:40:08.212556Z","steps":["trace[1685344904] 'process raft request' (duration: 248.019241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:40:08.720997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.470393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:40:08.721192Z","caller":"traceutil/trace.go:171","msg":"trace[1145909373] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"407.014911ms","start":"2026-05-27T13:40:08.314155Z","end":"2026-05-27T13:40:08.72117Z","steps":["trace[1145909373] 'process raft request' (duration: 406.929829ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:40:08.721344Z","caller":"traceutil/trace.go:171","msg":"trace[90553078] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"407.200416ms","start":"2026-05-27T13:40:08.314113Z","end":"2026-05-27T13:40:08.721313Z","steps":["trace[90553078] 'process raft request' (duration: 154.311112ms)","trace[90553078] 'compare' (duration: 252.292208ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:40:08.721432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:40:08.314091Z","time spent":"407.298049ms","remote":"127.0.0.1:35358","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-05-27T13:40:08.721944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:40:08.314139Z","time spent":"407.087804ms","remote":"127.0.0.1:35358","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-05-27T13:40:09.428586Z","caller":"traceutil/trace.go:171","msg":"trace[28244843] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"102.324748ms","start":"2026-05-27T13:40:09.326233Z","end":"2026-05-27T13:40:09.428558Z","steps":["trace[28244843] 'process raft request' (duration: 102.129032ms)"],"step_count":1}