{"level":"warn","ts":"2026-04-15T07:30:34.241726Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T07:30:34.241798Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.170:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.170:2380","--initial-cluster=instance=https://199.19.213.170:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.170:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.170: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-04-15T07:30:34.241876Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T07:30:34.24189Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-04-15T07:30:34.241925Z","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-04-15T07:30:34.242702Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"]} {"level":"info","ts":"2026-04-15T07:30:34.242777Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.170: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-04-15T07:30:34.247125Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.13869ms"} {"level":"info","ts":"2026-04-15T07:30:34.257765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"80be33c6b0d5a492","cluster-id":"abad33c2eec87dc"} {"level":"info","ts":"2026-04-15T07:30:34.257859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T07:30:34.257881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 0"} {"level":"info","ts":"2026-04-15T07:30:34.257892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 80be33c6b0d5a492 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T07:30:34.257901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 1"} {"level":"info","ts":"2026-04-15T07:30:34.257941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"warn","ts":"2026-04-15T07:30:34.264972Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T07:30:34.268023Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T07:30:34.269161Z","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-04-15T07:30:34.272211Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"80be33c6b0d5a492","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T07:30:34.272977Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"80be33c6b0d5a492","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T07:30:34.273251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"info","ts":"2026-04-15T07:30:34.273346Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","added-peer-id":"80be33c6b0d5a492","added-peer-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-04-15T07:30:34.273414Z","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-04-15T07:30:34.27345Z","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-04-15T07:30:34.27346Z","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-04-15T07:30:34.276475Z","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-04-15T07:30:34.276564Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-04-15T07:30:34.276606Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-04-15T07:30:34.27674Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"80be33c6b0d5a492","initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T07:30:34.276783Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T07:30:34.959037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T07:30:34.959101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T07:30:34.959149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgPreVoteResp from 80be33c6b0d5a492 at term 1"} {"level":"info","ts":"2026-04-15T07:30:34.959183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became candidate at term 2"} {"level":"info","ts":"2026-04-15T07:30:34.959196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgVoteResp from 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-04-15T07:30:34.959219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became leader at term 2"} {"level":"info","ts":"2026-04-15T07:30:34.959242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 80be33c6b0d5a492 elected leader 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-04-15T07:30:34.960335Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:30:34.961411Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"80be33c6b0d5a492","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.170:2379]}","request-path":"/0/members/80be33c6b0d5a492/attributes","cluster-id":"abad33c2eec87dc","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T07:30:34.961428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:30:34.961548Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:30:34.9621Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T07:30:34.96216Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T07:30:34.962223Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:30:34.962329Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:30:34.962363Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:30:34.964941Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T07:30:34.96826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.170:2379"} {"level":"info","ts":"2026-04-15T07:30:42.054169Z","caller":"traceutil/trace.go:171","msg":"trace[580495541] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"139.690237ms","start":"2026-04-15T07:30:41.914441Z","end":"2026-04-15T07:30:42.054131Z","steps":["trace[580495541] 'process raft request' (duration: 132.003318ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:42.055778Z","caller":"traceutil/trace.go:171","msg":"trace[157951022] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"104.815514ms","start":"2026-04-15T07:30:41.950925Z","end":"2026-04-15T07:30:42.05574Z","steps":["trace[157951022] 'process raft request' (duration: 104.585764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:43.844678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.367107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:30:43.844868Z","caller":"traceutil/trace.go:171","msg":"trace[592201752] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"283.323215ms","start":"2026-04-15T07:30:43.56149Z","end":"2026-04-15T07:30:43.844813Z","steps":["trace[592201752] 'process raft request' (duration: 152.181156ms)","trace[592201752] 'compare' (duration: 130.218337ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:43.911704Z","caller":"traceutil/trace.go:171","msg":"trace[2021100319] linearizableReadLoop","detail":"{readStateIndex:379; appliedIndex:377; }","duration":"309.925159ms","start":"2026-04-15T07:30:43.601756Z","end":"2026-04-15T07:30:43.911682Z","steps":["trace[2021100319] 'read index received' (duration: 111.817643ms)","trace[2021100319] 'applied index is now lower than readState.Index' (duration: 198.104226ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:30:43.911869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.076809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-15T07:30:43.911901Z","caller":"traceutil/trace.go:171","msg":"trace[831833461] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:367; }","duration":"310.20315ms","start":"2026-04-15T07:30:43.601691Z","end":"2026-04-15T07:30:43.911894Z","steps":["trace[831833461] 'agreement among raft nodes before linearized reading' (duration: 310.069179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:43.91193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:43.60166Z","time spent":"310.26329ms","remote":"127.0.0.1:60972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-04-15T07:30:43.912092Z","caller":"traceutil/trace.go:171","msg":"trace[1479702329] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"340.280445ms","start":"2026-04-15T07:30:43.57178Z","end":"2026-04-15T07:30:43.91206Z","steps":["trace[1479702329] 'process raft request' (duration: 339.787034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:43.912266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:43.571749Z","time spent":"340.436495ms","remote":"127.0.0.1:60954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:30:44.116489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.478742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:30:44.116579Z","caller":"traceutil/trace.go:171","msg":"trace[522664473] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"171.115394ms","start":"2026-04-15T07:30:43.94545Z","end":"2026-04-15T07:30:44.116566Z","steps":["trace[522664473] 'process raft request' (duration: 54.502262ms)","trace[522664473] 'compare' (duration: 116.356331ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:44.158647Z","caller":"traceutil/trace.go:171","msg":"trace[1275690090] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"213.135758ms","start":"2026-04-15T07:30:43.945482Z","end":"2026-04-15T07:30:44.158618Z","steps":["trace[1275690090] 'process raft request' (duration: 212.896227ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.159078Z","caller":"traceutil/trace.go:171","msg":"trace[1718396437] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:379; }","duration":"213.121438ms","start":"2026-04-15T07:30:43.945939Z","end":"2026-04-15T07:30:44.159061Z","steps":["trace[1718396437] 'read index received' (duration: 54.028009ms)","trace[1718396437] 'applied index is now lower than readState.Index' (duration: 159.092329ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:44.159178Z","caller":"traceutil/trace.go:171","msg":"trace[4220627] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"213.41151ms","start":"2026-04-15T07:30:43.945756Z","end":"2026-04-15T07:30:44.159168Z","steps":["trace[4220627] 'process raft request' (duration: 212.789067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.159333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.370169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-15T07:30:44.159335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.694934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T07:30:44.15938Z","caller":"traceutil/trace.go:171","msg":"trace[1207784822] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:370; }","duration":"213.455879ms","start":"2026-04-15T07:30:43.945911Z","end":"2026-04-15T07:30:44.159367Z","steps":["trace[1207784822] 'agreement among raft nodes before linearized reading' (duration: 213.356729ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.159389Z","caller":"traceutil/trace.go:171","msg":"trace[1615346187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:370; }","duration":"100.811774ms","start":"2026-04-15T07:30:44.058562Z","end":"2026-04-15T07:30:44.159374Z","steps":["trace[1615346187] 'agreement among raft nodes before linearized reading' (duration: 100.685044ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.304691Z","caller":"traceutil/trace.go:171","msg":"trace[847561640] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:382; }","duration":"135.374234ms","start":"2026-04-15T07:30:44.169298Z","end":"2026-04-15T07:30:44.304673Z","steps":["trace[847561640] 'read index received' (duration: 46.699105ms)","trace[847561640] 'applied index is now lower than readState.Index' (duration: 88.674169ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:44.304779Z","caller":"traceutil/trace.go:171","msg":"trace[2078491182] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"135.846085ms","start":"2026-04-15T07:30:44.168923Z","end":"2026-04-15T07:30:44.304769Z","steps":["trace[2078491182] 'process raft request' (duration: 135.713525ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.304852Z","caller":"traceutil/trace.go:171","msg":"trace[648760040] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"140.089555ms","start":"2026-04-15T07:30:44.164699Z","end":"2026-04-15T07:30:44.304789Z","steps":["trace[648760040] 'process raft request' (duration: 135.398282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.305095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.799106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-9zrfc\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-04-15T07:30:44.305148Z","caller":"traceutil/trace.go:171","msg":"trace[1023163702] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-9zrfc; range_end:; response_count:1; response_revision:373; }","duration":"135.854666ms","start":"2026-04-15T07:30:44.169281Z","end":"2026-04-15T07:30:44.305136Z","steps":["trace[1023163702] 'agreement among raft nodes before linearized reading' (duration: 135.729846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.854669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.082773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:30:44.854851Z","caller":"traceutil/trace.go:171","msg":"trace[581628815] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:390; }","duration":"510.909741ms","start":"2026-04-15T07:30:44.343927Z","end":"2026-04-15T07:30:44.854836Z","steps":["trace[581628815] 'read index received' (duration: 290.519286ms)","trace[581628815] 'applied index is now lower than readState.Index' (duration: 220.389455ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:44.854916Z","caller":"traceutil/trace.go:171","msg":"trace[1643242970] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"528.683704ms","start":"2026-04-15T07:30:44.326225Z","end":"2026-04-15T07:30:44.854908Z","steps":["trace[1643242970] 'process raft request' (duration: 528.550373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.854981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.326216Z","time spent":"528.722174ms","remote":"127.0.0.1:32978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:30:44.855069Z","caller":"traceutil/trace.go:171","msg":"trace[551218001] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"528.986265ms","start":"2026-04-15T07:30:44.326037Z","end":"2026-04-15T07:30:44.855023Z","steps":["trace[551218001] 'process raft request' (duration: 308.47045ms)","trace[551218001] 'compare' (duration: 219.921573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:30:44.855163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.326023Z","time spent":"529.101746ms","remote":"127.0.0.1:60824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:30:44.855141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.886965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T07:30:44.855246Z","caller":"traceutil/trace.go:171","msg":"trace[886165722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:380; }","duration":"529.051466ms","start":"2026-04-15T07:30:44.326169Z","end":"2026-04-15T07:30:44.85522Z","steps":["trace[886165722] 'agreement among raft nodes before linearized reading' (duration: 528.804745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.855303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.32614Z","time spent":"529.154756ms","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T07:30:44.867029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.910145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"warn","ts":"2026-04-15T07:30:44.867096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.746928ms","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-04-15T07:30:44.867164Z","caller":"traceutil/trace.go:171","msg":"trace[1038181215] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:382; }","duration":"292.871078ms","start":"2026-04-15T07:30:44.574276Z","end":"2026-04-15T07:30:44.867147Z","steps":["trace[1038181215] 'agreement among raft nodes before linearized reading' (duration: 292.755337ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.867154Z","caller":"traceutil/trace.go:171","msg":"trace[277867572] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"509.108593ms","start":"2026-04-15T07:30:44.357991Z","end":"2026-04-15T07:30:44.867099Z","steps":["trace[277867572] 'process raft request' (duration: 508.836031ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.867013Z","caller":"traceutil/trace.go:171","msg":"trace[1813527664] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"506.946354ms","start":"2026-04-15T07:30:44.36004Z","end":"2026-04-15T07:30:44.866986Z","steps":["trace[1813527664] 'process raft request' (duration: 506.900004ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:44.86707Z","caller":"traceutil/trace.go:171","msg":"trace[2048629721] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:382; }","duration":"476.955155ms","start":"2026-04-15T07:30:44.390105Z","end":"2026-04-15T07:30:44.86706Z","steps":["trace[2048629721] 'agreement among raft nodes before linearized reading' (duration: 476.870005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.867255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.274072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:30:44.867319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.35798Z","time spent":"509.233264ms","remote":"127.0.0.1:60954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:30:44.867787Z","caller":"traceutil/trace.go:171","msg":"trace[623357674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"450.819436ms","start":"2026-04-15T07:30:44.416891Z","end":"2026-04-15T07:30:44.86771Z","steps":["trace[623357674] 'agreement among raft nodes before linearized reading' (duration: 450.234753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:44.867455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.390039Z","time spent":"477.408317ms","remote":"127.0.0.1:60938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4392,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-15T07:30:44.867887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.41687Z","time spent":"450.997497ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T07:30:44.86814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:44.360014Z","time spent":"507.416206ms","remote":"127.0.0.1:60824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:30:45.107934Z","caller":"traceutil/trace.go:171","msg":"trace[146969914] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"236.876912ms","start":"2026-04-15T07:30:44.871024Z","end":"2026-04-15T07:30:45.107901Z","steps":["trace[146969914] 'process raft request' (duration: 180.03641ms)","trace[146969914] 'compare' (duration: 56.54081ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:45.108409Z","caller":"traceutil/trace.go:171","msg":"trace[1079363670] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:394; }","duration":"236.488861ms","start":"2026-04-15T07:30:44.871898Z","end":"2026-04-15T07:30:45.108387Z","steps":["trace[1079363670] 'read index received' (duration: 23.224837ms)","trace[1079363670] 'applied index is now lower than readState.Index' (duration: 213.262924ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:45.108488Z","caller":"traceutil/trace.go:171","msg":"trace[81153288] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"230.406344ms","start":"2026-04-15T07:30:44.878067Z","end":"2026-04-15T07:30:45.108473Z","steps":["trace[81153288] 'process raft request' (duration: 230.246652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:45.10868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.724953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-15T07:30:45.10887Z","caller":"traceutil/trace.go:171","msg":"trace[1284463444] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:386; }","duration":"237.012354ms","start":"2026-04-15T07:30:44.871837Z","end":"2026-04-15T07:30:45.108849Z","steps":["trace[1284463444] 'agreement among raft nodes before linearized reading' (duration: 236.688832ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:45.115012Z","caller":"traceutil/trace.go:171","msg":"trace[822190750] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"199.662637ms","start":"2026-04-15T07:30:44.915313Z","end":"2026-04-15T07:30:45.114975Z","steps":["trace[822190750] 'process raft request' (duration: 199.449626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:45.115015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.786698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:30:45.115277Z","caller":"traceutil/trace.go:171","msg":"trace[910035615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:387; }","duration":"200.08215ms","start":"2026-04-15T07:30:44.915173Z","end":"2026-04-15T07:30:45.115255Z","steps":["trace[910035615] 'agreement among raft nodes before linearized reading' (duration: 199.718028ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:58.067119Z","caller":"traceutil/trace.go:171","msg":"trace[988154434] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"125.462286ms","start":"2026-04-15T07:30:57.941621Z","end":"2026-04-15T07:30:58.067083Z","steps":["trace[988154434] 'read index received' (duration: 96.405398ms)","trace[988154434] 'applied index is now lower than readState.Index' (duration: 29.055678ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:58.067166Z","caller":"traceutil/trace.go:171","msg":"trace[1879920719] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"125.554888ms","start":"2026-04-15T07:30:57.941582Z","end":"2026-04-15T07:30:58.067137Z","steps":["trace[1879920719] 'process raft request' (duration: 96.530511ms)","trace[1879920719] 'compare' (duration: 28.848384ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:30:58.06727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.618479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:30:58.06731Z","caller":"traceutil/trace.go:171","msg":"trace[307087739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:461; }","duration":"125.70429ms","start":"2026-04-15T07:30:57.941595Z","end":"2026-04-15T07:30:58.067299Z","steps":["trace[307087739] 'agreement among raft nodes before linearized reading' (duration: 125.592008ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:59.630198Z","caller":"traceutil/trace.go:171","msg":"trace[138324754] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:479; }","duration":"195.166426ms","start":"2026-04-15T07:30:59.434996Z","end":"2026-04-15T07:30:59.630163Z","steps":["trace[138324754] 'read index received' (duration: 194.802799ms)","trace[138324754] 'applied index is now lower than readState.Index' (duration: 362.447µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:30:59.630379Z","caller":"traceutil/trace.go:171","msg":"trace[61770409] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"451.309974ms","start":"2026-04-15T07:30:59.179055Z","end":"2026-04-15T07:30:59.630365Z","steps":["trace[61770409] 'process raft request' (duration: 450.852095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:59.630534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:30:59.179018Z","time spent":"451.396645ms","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:30:59.630537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.496562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-15T07:30:59.630618Z","caller":"traceutil/trace.go:171","msg":"trace[219778882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:464; }","duration":"195.652206ms","start":"2026-04-15T07:30:59.434945Z","end":"2026-04-15T07:30:59.630597Z","steps":["trace[219778882] 'agreement among raft nodes before linearized reading' (duration: 195.502602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:02.136708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714010831197767,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T07:31:02.637096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714010831197767,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T07:31:03.041144Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.461005056s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T07:31:03.041659Z","caller":"traceutil/trace.go:171","msg":"trace[1034509195] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.461634269s","start":"2026-04-15T07:31:01.58Z","end":"2026-04-15T07:31:03.041634Z","steps":["trace[1034509195] 'process raft request' (duration: 1.461495136s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.041789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.579979Z","time spent":"1.461741672s","remote":"127.0.0.1:60794","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-04-15T07:31:03.124566Z","caller":"traceutil/trace.go:171","msg":"trace[1729639830] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.543944659s","start":"2026-04-15T07:31:01.580592Z","end":"2026-04-15T07:31:03.124536Z","steps":["trace[1729639830] 'process raft request' (duration: 1.543769046s)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.124618Z","caller":"traceutil/trace.go:171","msg":"trace[1656815700] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.543905739s","start":"2026-04-15T07:31:01.580691Z","end":"2026-04-15T07:31:03.124597Z","steps":["trace[1656815700] 'process raft request' (duration: 1.543783316s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.124755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.580564Z","time spent":"1.544076313s","remote":"127.0.0.1:60794","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-04-15T07:31:03.12481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.580681Z","time spent":"1.544001482s","remote":"127.0.0.1:60794","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-04-15T07:31:03.124939Z","caller":"traceutil/trace.go:171","msg":"trace[1436946050] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.536765153s","start":"2026-04-15T07:31:01.588155Z","end":"2026-04-15T07:31:03.12492Z","steps":["trace[1436946050] 'process raft request' (duration: 1.536409735s)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.124957Z","caller":"traceutil/trace.go:171","msg":"trace[1769259746] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.537850365s","start":"2026-04-15T07:31:01.587062Z","end":"2026-04-15T07:31:03.124913Z","steps":["trace[1769259746] 'process raft request' (duration: 1.537464446s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.125018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.588133Z","time spent":"1.536850054s","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:31:03.125098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.587053Z","time spent":"1.537973537s","remote":"127.0.0.1:60794","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-04-15T07:31:03.125168Z","caller":"traceutil/trace.go:171","msg":"trace[1059464957] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.52942583s","start":"2026-04-15T07:31:01.595662Z","end":"2026-04-15T07:31:03.125088Z","steps":["trace[1059464957] 'process raft request' (duration: 1.52900441s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.125409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.59564Z","time spent":"1.529649415s","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:31:03.125642Z","caller":"traceutil/trace.go:171","msg":"trace[1787160445] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.521124638s","start":"2026-04-15T07:31:01.604498Z","end":"2026-04-15T07:31:03.125623Z","steps":["trace[1787160445] 'process raft request' (duration: 1.520809781s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.125732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.60449Z","time spent":"1.52118477s","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:31:03.12588Z","caller":"traceutil/trace.go:171","msg":"trace[382289050] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.521590039s","start":"2026-04-15T07:31:01.604277Z","end":"2026-04-15T07:31:03.125868Z","steps":["trace[382289050] 'process raft request' (duration: 1.520430953s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.125935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.604256Z","time spent":"1.52165577s","remote":"127.0.0.1:60794","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-04-15T07:31:03.126074Z","caller":"traceutil/trace.go:171","msg":"trace[182436705] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.510156322s","start":"2026-04-15T07:31:01.61591Z","end":"2026-04-15T07:31:03.126066Z","steps":["trace[182436705] 'process raft request' (duration: 1.509474887s)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.126108Z","caller":"traceutil/trace.go:171","msg":"trace[1042337199] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:518; }","duration":"1.490281391s","start":"2026-04-15T07:31:01.635815Z","end":"2026-04-15T07:31:03.126097Z","steps":["trace[1042337199] 'read index received' (duration: 1.40567099s)","trace[1042337199] 'applied index is now lower than readState.Index' (duration: 84.609631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:03.126122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.615892Z","time spent":"1.510212714s","remote":"127.0.0.1:60794","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-04-15T07:31:03.126169Z","caller":"traceutil/trace.go:171","msg":"trace[1667904936] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.502251408s","start":"2026-04-15T07:31:01.623911Z","end":"2026-04-15T07:31:03.126163Z","steps":["trace[1667904936] 'process raft request' (duration: 1.501580933s)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.126187Z","caller":"traceutil/trace.go:171","msg":"trace[164315857] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.375214677s","start":"2026-04-15T07:31:01.750965Z","end":"2026-04-15T07:31:03.12618Z","steps":["trace[164315857] 'process raft request' (duration: 1.375039563s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.126211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.623891Z","time spent":"1.50229374s","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:31:03.126227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.750945Z","time spent":"1.375265877s","remote":"127.0.0.1:60794","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-04-15T07:31:03.126282Z","caller":"traceutil/trace.go:171","msg":"trace[2013946993] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.462868903s","start":"2026-04-15T07:31:01.663406Z","end":"2026-04-15T07:31:03.126275Z","steps":["trace[2013946993] 'process raft request' (duration: 1.462168367s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.126314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.66338Z","time spent":"1.462918623s","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:31:03.126424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.490598628s","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-04-15T07:31:03.126456Z","caller":"traceutil/trace.go:171","msg":"trace[946404431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"1.490669389s","start":"2026-04-15T07:31:01.635778Z","end":"2026-04-15T07:31:03.126448Z","steps":["trace[946404431] 'agreement among raft nodes before linearized reading' (duration: 1.490501106s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.126479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.635764Z","time spent":"1.49070952s","remote":"127.0.0.1:32814","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-04-15T07:31:03.152699Z","caller":"traceutil/trace.go:171","msg":"trace[1591971927] transaction","detail":"{read_only:false; number_of_response:1; response_revision:516; }","duration":"101.493498ms","start":"2026-04-15T07:31:03.051189Z","end":"2026-04-15T07:31:03.152683Z","steps":["trace[1591971927] 'process raft request' (duration: 101.387186ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.152831Z","caller":"traceutil/trace.go:171","msg":"trace[1119771083] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"104.70105ms","start":"2026-04-15T07:31:03.048116Z","end":"2026-04-15T07:31:03.152817Z","steps":["trace[1119771083] 'process raft request' (duration: 104.301332ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.153049Z","caller":"traceutil/trace.go:171","msg":"trace[1665902573] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"102.120203ms","start":"2026-04-15T07:31:03.050911Z","end":"2026-04-15T07:31:03.153031Z","steps":["trace[1665902573] 'process raft request' (duration: 101.624882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.153218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.298067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:03.153248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.656837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-15T07:31:03.153266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.149959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T07:31:03.153276Z","caller":"traceutil/trace.go:171","msg":"trace[909453899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"240.41449ms","start":"2026-04-15T07:31:02.912832Z","end":"2026-04-15T07:31:03.153246Z","steps":["trace[909453899] 'agreement among raft nodes before linearized reading' (duration: 240.303157ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.153285Z","caller":"traceutil/trace.go:171","msg":"trace[1809517954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"172.207211ms","start":"2026-04-15T07:31:02.981072Z","end":"2026-04-15T07:31:03.153279Z","steps":["trace[1809517954] 'agreement among raft nodes before linearized reading' (duration: 172.153279ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.153286Z","caller":"traceutil/trace.go:171","msg":"trace[971665541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"741.76576ms","start":"2026-04-15T07:31:02.411509Z","end":"2026-04-15T07:31:03.153275Z","steps":["trace[971665541] 'agreement among raft nodes before linearized reading' (duration: 741.629097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.153309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:02.411456Z","time spent":"741.847752ms","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-15T07:31:03.153647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438811118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-15T07:31:03.153685Z","caller":"traceutil/trace.go:171","msg":"trace[125565731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"1.438877889s","start":"2026-04-15T07:31:01.714797Z","end":"2026-04-15T07:31:03.153675Z","steps":["trace[125565731] 'agreement among raft nodes before linearized reading' (duration: 1.438121823s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.153709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:01.714784Z","time spent":"1.438919451s","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T07:31:03.375902Z","caller":"traceutil/trace.go:171","msg":"trace[1286189218] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"241.259412ms","start":"2026-04-15T07:31:03.134607Z","end":"2026-04-15T07:31:03.375866Z","steps":["trace[1286189218] 'process raft request' (duration: 241.15535ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.375913Z","caller":"traceutil/trace.go:171","msg":"trace[734763993] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"241.423315ms","start":"2026-04-15T07:31:03.134459Z","end":"2026-04-15T07:31:03.375882Z","steps":["trace[734763993] 'process raft request' (duration: 176.959834ms)","trace[734763993] 'compare' (duration: 64.201375ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:03.376106Z","caller":"traceutil/trace.go:171","msg":"trace[1670015527] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"227.107667ms","start":"2026-04-15T07:31:03.148991Z","end":"2026-04-15T07:31:03.376099Z","steps":["trace[1670015527] 'process raft request' (duration: 226.908042ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.37603Z","caller":"traceutil/trace.go:171","msg":"trace[1146234028] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:533; }","duration":"216.214033ms","start":"2026-04-15T07:31:03.159797Z","end":"2026-04-15T07:31:03.376011Z","steps":["trace[1146234028] 'read index received' (duration: 151.67679ms)","trace[1146234028] 'applied index is now lower than readState.Index' (duration: 64.536413ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:03.376139Z","caller":"traceutil/trace.go:171","msg":"trace[249859434] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"232.813225ms","start":"2026-04-15T07:31:03.143271Z","end":"2026-04-15T07:31:03.376084Z","steps":["trace[249859434] 'process raft request' (duration: 232.585229ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.376205Z","caller":"traceutil/trace.go:171","msg":"trace[2059385998] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"235.112305ms","start":"2026-04-15T07:31:03.141027Z","end":"2026-04-15T07:31:03.376139Z","steps":["trace[2059385998] 'process raft request' (duration: 234.768876ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.376261Z","caller":"traceutil/trace.go:171","msg":"trace[1236762408] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"232.127228ms","start":"2026-04-15T07:31:03.144125Z","end":"2026-04-15T07:31:03.376253Z","steps":["trace[1236762408] 'process raft request' (duration: 231.750979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.376379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.52279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:03.376411Z","caller":"traceutil/trace.go:171","msg":"trace[1227946630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"216.639653ms","start":"2026-04-15T07:31:03.159764Z","end":"2026-04-15T07:31:03.376404Z","steps":["trace[1227946630] 'agreement among raft nodes before linearized reading' (duration: 216.442578ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.37651Z","caller":"traceutil/trace.go:171","msg":"trace[1684453309] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"235.464763ms","start":"2026-04-15T07:31:03.141037Z","end":"2026-04-15T07:31:03.376502Z","steps":["trace[1684453309] 'process raft request' (duration: 234.794017ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.376564Z","caller":"traceutil/trace.go:171","msg":"trace[345792145] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"225.507461ms","start":"2026-04-15T07:31:03.151052Z","end":"2026-04-15T07:31:03.376559Z","steps":["trace[345792145] 'process raft request' (duration: 224.923098ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.376613Z","caller":"traceutil/trace.go:171","msg":"trace[571968844] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"225.682384ms","start":"2026-04-15T07:31:03.150926Z","end":"2026-04-15T07:31:03.376608Z","steps":["trace[571968844] 'process raft request' (duration: 225.012508ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.437237Z","caller":"traceutil/trace.go:171","msg":"trace[1294199845] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"270.383273ms","start":"2026-04-15T07:31:03.166822Z","end":"2026-04-15T07:31:03.437205Z","steps":["trace[1294199845] 'process raft request' (duration: 270.147218ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.437442Z","caller":"traceutil/trace.go:171","msg":"trace[1731758229] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"270.750681ms","start":"2026-04-15T07:31:03.166682Z","end":"2026-04-15T07:31:03.437433Z","steps":["trace[1731758229] 'process raft request' (duration: 270.183658ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.437893Z","caller":"traceutil/trace.go:171","msg":"trace[1451614544] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"271.006067ms","start":"2026-04-15T07:31:03.166876Z","end":"2026-04-15T07:31:03.437882Z","steps":["trace[1451614544] 'process raft request' (duration: 270.146217ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.43797Z","caller":"traceutil/trace.go:171","msg":"trace[1935371931] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"259.729545ms","start":"2026-04-15T07:31:03.178198Z","end":"2026-04-15T07:31:03.437928Z","steps":["trace[1935371931] 'process raft request' (duration: 258.907406ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.43799Z","caller":"traceutil/trace.go:171","msg":"trace[134589268] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"243.36815ms","start":"2026-04-15T07:31:03.194597Z","end":"2026-04-15T07:31:03.437965Z","steps":["trace[134589268] 'process raft request' (duration: 242.601792ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.438102Z","caller":"traceutil/trace.go:171","msg":"trace[37212409] transaction","detail":"{read_only:false; number_of_response:1; response_revision:528; }","duration":"267.186142ms","start":"2026-04-15T07:31:03.170832Z","end":"2026-04-15T07:31:03.438018Z","steps":["trace[37212409] 'process raft request' (duration: 266.225449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.561422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.109844ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-15T07:31:03.561805Z","caller":"traceutil/trace.go:171","msg":"trace[2060159747] transaction","detail":"{read_only:false; number_of_response:0; response_revision:530; }","duration":"180.33409ms","start":"2026-04-15T07:31:03.381405Z","end":"2026-04-15T07:31:03.561739Z","steps":["trace[2060159747] 'process raft request' (duration: 180.189767ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.561828Z","caller":"traceutil/trace.go:171","msg":"trace[46461564] transaction","detail":"{read_only:false; number_of_response:0; response_revision:530; }","duration":"179.88678ms","start":"2026-04-15T07:31:03.381904Z","end":"2026-04-15T07:31:03.56179Z","steps":["trace[46461564] 'process raft request' (duration: 179.727656ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.561905Z","caller":"traceutil/trace.go:171","msg":"trace[588038463] transaction","detail":"{read_only:false; number_of_response:0; response_revision:530; }","duration":"179.710686ms","start":"2026-04-15T07:31:03.382144Z","end":"2026-04-15T07:31:03.561855Z","steps":["trace[588038463] 'process raft request' (duration: 179.509932ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.56212Z","caller":"traceutil/trace.go:171","msg":"trace[1597200528] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"165.849027ms","start":"2026-04-15T07:31:03.396264Z","end":"2026-04-15T07:31:03.562113Z","steps":["trace[1597200528] 'process raft request' (duration: 165.480249ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.562288Z","caller":"traceutil/trace.go:171","msg":"trace[2004972391] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"140.376117ms","start":"2026-04-15T07:31:03.421906Z","end":"2026-04-15T07:31:03.562282Z","steps":["trace[2004972391] 'process raft request' (duration: 140.123332ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.562292Z","caller":"traceutil/trace.go:171","msg":"trace[513317624] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"130.749932ms","start":"2026-04-15T07:31:03.431527Z","end":"2026-04-15T07:31:03.562277Z","steps":["trace[513317624] 'process raft request' (duration: 130.592349ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.562424Z","caller":"traceutil/trace.go:171","msg":"trace[1028282792] transaction","detail":"{read_only:false; number_of_response:0; response_revision:530; }","duration":"179.490311ms","start":"2026-04-15T07:31:03.382778Z","end":"2026-04-15T07:31:03.562269Z","steps":["trace[1028282792] 'process raft request' (duration: 178.896598ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.648461Z","caller":"traceutil/trace.go:171","msg":"trace[15928651] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"198.869334ms","start":"2026-04-15T07:31:03.449576Z","end":"2026-04-15T07:31:03.648445Z","steps":["trace[15928651] 'process raft request' (duration: 198.711381ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.648641Z","caller":"traceutil/trace.go:171","msg":"trace[1993312512] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"139.693022ms","start":"2026-04-15T07:31:03.508922Z","end":"2026-04-15T07:31:03.648615Z","steps":["trace[1993312512] 'process raft request' (duration: 139.486377ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.678064Z","caller":"traceutil/trace.go:171","msg":"trace[493608663] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"104.607587ms","start":"2026-04-15T07:31:03.573431Z","end":"2026-04-15T07:31:03.678039Z","steps":["trace[493608663] 'process raft request' (duration: 98.888169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.678296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.300303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"warn","ts":"2026-04-15T07:31:03.678319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.195405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-15T07:31:03.678348Z","caller":"traceutil/trace.go:171","msg":"trace[2092571955] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:537; }","duration":"114.373036ms","start":"2026-04-15T07:31:03.563962Z","end":"2026-04-15T07:31:03.678335Z","steps":["trace[2092571955] 'agreement among raft nodes before linearized reading' (duration: 114.289864ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.678378Z","caller":"traceutil/trace.go:171","msg":"trace[562837162] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:537; }","duration":"115.298386ms","start":"2026-04-15T07:31:03.563066Z","end":"2026-04-15T07:31:03.678365Z","steps":["trace[562837162] 'agreement among raft nodes before linearized reading' (duration: 115.161193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:03.678378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.406096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:995"} {"level":"info","ts":"2026-04-15T07:31:03.678415Z","caller":"traceutil/trace.go:171","msg":"trace[1574118615] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:537; }","duration":"114.491638ms","start":"2026-04-15T07:31:03.563913Z","end":"2026-04-15T07:31:03.678404Z","steps":["trace[1574118615] 'agreement among raft nodes before linearized reading' (duration: 114.384036ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.811865Z","caller":"traceutil/trace.go:171","msg":"trace[1994960777] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"109.002696ms","start":"2026-04-15T07:31:03.702829Z","end":"2026-04-15T07:31:03.811832Z","steps":["trace[1994960777] 'process raft request' (duration: 98.41986ms)","trace[1994960777] 'compare' (duration: 10.170337ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:03.811948Z","caller":"traceutil/trace.go:171","msg":"trace[733990953] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"105.815445ms","start":"2026-04-15T07:31:03.706113Z","end":"2026-04-15T07:31:03.811929Z","steps":["trace[733990953] 'process raft request' (duration: 105.638161ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:03.999864Z","caller":"traceutil/trace.go:171","msg":"trace[1509140204] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"129.280989ms","start":"2026-04-15T07:31:03.870565Z","end":"2026-04-15T07:31:03.999846Z","steps":["trace[1509140204] 'process raft request' (duration: 129.094025ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.000074Z","caller":"traceutil/trace.go:171","msg":"trace[1919132304] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"121.573976ms","start":"2026-04-15T07:31:03.878469Z","end":"2026-04-15T07:31:04.000043Z","steps":["trace[1919132304] 'process raft request' (duration: 121.343481ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.061872Z","caller":"traceutil/trace.go:171","msg":"trace[272140349] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:568; }","duration":"124.314275ms","start":"2026-04-15T07:31:03.93754Z","end":"2026-04-15T07:31:04.061854Z","steps":["trace[272140349] 'read index received' (duration: 62.110238ms)","trace[272140349] 'applied index is now lower than readState.Index' (duration: 62.201367ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:04.061988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.416267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:04.062005Z","caller":"traceutil/trace.go:171","msg":"trace[1264178724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"124.495999ms","start":"2026-04-15T07:31:03.937503Z","end":"2026-04-15T07:31:04.061999Z","steps":["trace[1264178724] 'agreement among raft nodes before linearized reading' (duration: 124.416197ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.062217Z","caller":"traceutil/trace.go:171","msg":"trace[2101689309] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"129.133823ms","start":"2026-04-15T07:31:03.933045Z","end":"2026-04-15T07:31:04.062178Z","steps":["trace[2101689309] 'process raft request' (duration: 128.652802ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.23686Z","caller":"traceutil/trace.go:171","msg":"trace[592046743] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"211.907235ms","start":"2026-04-15T07:31:04.024928Z","end":"2026-04-15T07:31:04.236835Z","steps":["trace[592046743] 'process raft request' (duration: 211.855584ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.237204Z","caller":"traceutil/trace.go:171","msg":"trace[583291995] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"222.832758ms","start":"2026-04-15T07:31:04.014355Z","end":"2026-04-15T07:31:04.237188Z","steps":["trace[583291995] 'process raft request' (duration: 128.943445ms)","trace[583291995] 'compare' (duration: 93.30122ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:04.415216Z","caller":"traceutil/trace.go:171","msg":"trace[1603282209] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"153.011541ms","start":"2026-04-15T07:31:04.262189Z","end":"2026-04-15T07:31:04.4152Z","steps":["trace[1603282209] 'process raft request' (duration: 152.950489ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.423775Z","caller":"traceutil/trace.go:171","msg":"trace[1141282023] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"340.979433ms","start":"2026-04-15T07:31:04.078791Z","end":"2026-04-15T07:31:04.419771Z","steps":["trace[1141282023] 'process raft request' (duration: 259.364394ms)","trace[1141282023] 'compare' (duration: 76.851078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:04.423955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:04.078771Z","time spent":"345.077668ms","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:31:04.592846Z","caller":"traceutil/trace.go:171","msg":"trace[919257258] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"137.154284ms","start":"2026-04-15T07:31:04.455669Z","end":"2026-04-15T07:31:04.592823Z","steps":["trace[919257258] 'process raft request' (duration: 82.169081ms)","trace[919257258] 'compare' (duration: 54.881041ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:04.593285Z","caller":"traceutil/trace.go:171","msg":"trace[1290832058] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"104.834785ms","start":"2026-04-15T07:31:04.48844Z","end":"2026-04-15T07:31:04.593275Z","steps":["trace[1290832058] 'process raft request' (duration: 104.758534ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:04.841074Z","caller":"traceutil/trace.go:171","msg":"trace[1125296521] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"221.264601ms","start":"2026-04-15T07:31:04.619782Z","end":"2026-04-15T07:31:04.841046Z","steps":["trace[1125296521] 'process raft request' (duration: 158.959798ms)","trace[1125296521] 'compare' (duration: 62.119318ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:04.842509Z","caller":"traceutil/trace.go:171","msg":"trace[638393387] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"124.674196ms","start":"2026-04-15T07:31:04.717817Z","end":"2026-04-15T07:31:04.842491Z","steps":["trace[638393387] 'process raft request' (duration: 124.462442ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:05.078437Z","caller":"traceutil/trace.go:171","msg":"trace[5218918] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:582; }","duration":"166.43635ms","start":"2026-04-15T07:31:04.911945Z","end":"2026-04-15T07:31:05.078381Z","steps":["trace[5218918] 'read index received' (duration: 27.922656ms)","trace[5218918] 'applied index is now lower than readState.Index' (duration: 138.512424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:05.078579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.603614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:05.07862Z","caller":"traceutil/trace.go:171","msg":"trace[650632709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"166.701046ms","start":"2026-04-15T07:31:04.911907Z","end":"2026-04-15T07:31:05.078608Z","steps":["trace[650632709] 'agreement among raft nodes before linearized reading' (duration: 166.608364ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:05.078644Z","caller":"traceutil/trace.go:171","msg":"trace[932898140] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"185.983263ms","start":"2026-04-15T07:31:04.892641Z","end":"2026-04-15T07:31:05.078624Z","steps":["trace[932898140] 'process raft request' (duration: 126.640243ms)","trace[932898140] 'compare' (duration: 58.93011ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:05.430157Z","caller":"traceutil/trace.go:171","msg":"trace[1653253990] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"113.483666ms","start":"2026-04-15T07:31:05.316609Z","end":"2026-04-15T07:31:05.430092Z","steps":["trace[1653253990] 'process raft request' (duration: 53.020149ms)","trace[1653253990] 'compare' (duration: 60.277852ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:05.758256Z","caller":"traceutil/trace.go:171","msg":"trace[1031044140] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"113.543027ms","start":"2026-04-15T07:31:05.644689Z","end":"2026-04-15T07:31:05.758232Z","steps":["trace[1031044140] 'process raft request' (duration: 106.349964ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:06.075316Z","caller":"traceutil/trace.go:171","msg":"trace[297187659] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"245.387717ms","start":"2026-04-15T07:31:05.829902Z","end":"2026-04-15T07:31:06.07529Z","steps":["trace[297187659] 'read index received' (duration: 214.899664ms)","trace[297187659] 'applied index is now lower than readState.Index' (duration: 30.486893ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:06.075451Z","caller":"traceutil/trace.go:171","msg":"trace[324362347] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"266.378649ms","start":"2026-04-15T07:31:05.809048Z","end":"2026-04-15T07:31:06.075426Z","steps":["trace[324362347] 'process raft request' (duration: 235.66287ms)","trace[324362347] 'compare' (duration: 30.291478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:06.076443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.511235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-04-15T07:31:06.076534Z","caller":"traceutil/trace.go:171","msg":"trace[1186003743] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:581; }","duration":"246.614928ms","start":"2026-04-15T07:31:05.829878Z","end":"2026-04-15T07:31:06.076493Z","steps":["trace[1186003743] 'agreement among raft nodes before linearized reading' (duration: 245.51144ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:06.136895Z","caller":"traceutil/trace.go:171","msg":"trace[703902078] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"125.713085ms","start":"2026-04-15T07:31:06.011159Z","end":"2026-04-15T07:31:06.136872Z","steps":["trace[703902078] 'process raft request' (duration: 125.368287ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:06.259324Z","caller":"traceutil/trace.go:171","msg":"trace[731802027] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"123.249464ms","start":"2026-04-15T07:31:06.136046Z","end":"2026-04-15T07:31:06.259295Z","steps":["trace[731802027] 'process raft request' (duration: 95.791616ms)","trace[731802027] 'compare' (duration: 27.255443ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:09.667697Z","caller":"traceutil/trace.go:171","msg":"trace[1539428669] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"185.464556ms","start":"2026-04-15T07:31:09.482209Z","end":"2026-04-15T07:31:09.667674Z","steps":["trace[1539428669] 'read index received' (duration: 185.24734ms)","trace[1539428669] 'applied index is now lower than readState.Index' (duration: 216.186µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:09.667858Z","caller":"traceutil/trace.go:171","msg":"trace[279006009] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"211.315862ms","start":"2026-04-15T07:31:09.456469Z","end":"2026-04-15T07:31:09.667785Z","steps":["trace[279006009] 'process raft request' (duration: 210.993393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:09.667924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.696293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-15T07:31:09.66796Z","caller":"traceutil/trace.go:171","msg":"trace[714100103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"185.790825ms","start":"2026-04-15T07:31:09.48216Z","end":"2026-04-15T07:31:09.667951Z","steps":["trace[714100103] 'agreement among raft nodes before linearized reading' (duration: 185.64195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:09.667975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.816287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T07:31:09.668042Z","caller":"traceutil/trace.go:171","msg":"trace[1225020264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"142.92649ms","start":"2026-04-15T07:31:09.525097Z","end":"2026-04-15T07:31:09.668023Z","steps":["trace[1225020264] 'agreement among raft nodes before linearized reading' (duration: 142.753605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:09.66803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.725295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T07:31:09.668084Z","caller":"traceutil/trace.go:171","msg":"trace[1635878487] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"142.788656ms","start":"2026-04-15T07:31:09.525279Z","end":"2026-04-15T07:31:09.668068Z","steps":["trace[1635878487] 'agreement among raft nodes before linearized reading' (duration: 142.624672ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:10.521905Z","caller":"traceutil/trace.go:171","msg":"trace[701181663] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"232.46731ms","start":"2026-04-15T07:31:10.289413Z","end":"2026-04-15T07:31:10.52188Z","steps":["trace[701181663] 'process raft request' (duration: 231.599846ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:11.162001Z","caller":"traceutil/trace.go:171","msg":"trace[247883415] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"248.560858ms","start":"2026-04-15T07:31:10.913407Z","end":"2026-04-15T07:31:11.161968Z","steps":["trace[247883415] 'read index received' (duration: 247.93931ms)","trace[247883415] 'applied index is now lower than readState.Index' (duration: 620.258µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:11.162182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.751133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:11.162271Z","caller":"traceutil/trace.go:171","msg":"trace[940921439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"248.925358ms","start":"2026-04-15T07:31:10.913331Z","end":"2026-04-15T07:31:11.162257Z","steps":["trace[940921439] 'agreement among raft nodes before linearized reading' (duration: 248.769334ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:11.162475Z","caller":"traceutil/trace.go:171","msg":"trace[1995112017] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"566.440551ms","start":"2026-04-15T07:31:10.596003Z","end":"2026-04-15T07:31:11.162444Z","steps":["trace[1995112017] 'process raft request' (duration: 565.276389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:11.163394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:10.595985Z","time spent":"567.294645ms","remote":"127.0.0.1:60954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:31:11.21613Z","caller":"traceutil/trace.go:171","msg":"trace[362339271] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"249.159623ms","start":"2026-04-15T07:31:10.966929Z","end":"2026-04-15T07:31:11.216088Z","steps":["trace[362339271] 'process raft request' (duration: 248.443143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:12.17386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714010831197963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T07:31:12.675055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714010831197963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T07:31:13.176369Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714010831197963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T07:31:13.346386Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.068490725s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T07:31:13.357147Z","caller":"traceutil/trace.go:171","msg":"trace[991047995] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"2.079406649s","start":"2026-04-15T07:31:11.277704Z","end":"2026-04-15T07:31:13.357111Z","steps":["trace[991047995] 'process raft request' (duration: 2.069035591s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.357249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.277669Z","time spent":"2.079530623s","remote":"127.0.0.1:60972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:31:13.357249Z","caller":"traceutil/trace.go:171","msg":"trace[1978452212] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"1.684332219s","start":"2026-04-15T07:31:11.672892Z","end":"2026-04-15T07:31:13.357224Z","steps":["trace[1978452212] 'read index received' (duration: 1.673779046s)","trace[1978452212] 'applied index is now lower than readState.Index' (duration: 10.550073ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:13.381203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.708223431s","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-04-15T07:31:13.381308Z","caller":"traceutil/trace.go:171","msg":"trace[613967152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"1.708446018s","start":"2026-04-15T07:31:11.672835Z","end":"2026-04-15T07:31:13.381281Z","steps":["trace[613967152] 'agreement among raft nodes before linearized reading' (duration: 1.684465414s)","trace[613967152] 'range keys from in-memory index tree' (duration: 23.698415ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:13.381408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.672814Z","time spent":"1.7085271s","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T07:31:13.381982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.646071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382035Z","caller":"traceutil/trace.go:171","msg":"trace[384777338] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:606; }","duration":"330.744673ms","start":"2026-04-15T07:31:13.051276Z","end":"2026-04-15T07:31:13.382021Z","steps":["trace[384777338] 'agreement among raft nodes before linearized reading' (duration: 330.656361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.38207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:13.051254Z","time spent":"330.807556ms","remote":"127.0.0.1:38670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-15T07:31:13.382216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.995571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.382308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.767219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.382347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.01847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382419Z","caller":"traceutil/trace.go:171","msg":"trace[1914600415] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:606; }","duration":"530.101113ms","start":"2026-04-15T07:31:12.852299Z","end":"2026-04-15T07:31:13.3824Z","steps":["trace[1914600415] 'agreement among raft nodes before linearized reading' (duration: 530.01ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:13.382459Z","caller":"traceutil/trace.go:171","msg":"trace[2002268015] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:606; }","duration":"393.943004ms","start":"2026-04-15T07:31:12.988444Z","end":"2026-04-15T07:31:13.382387Z","steps":["trace[2002268015] 'agreement among raft nodes before linearized reading' (duration: 393.714387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.38241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.868507ms","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":"warn","ts":"2026-04-15T07:31:13.382486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.852295Z","time spent":"530.173795ms","remote":"127.0.0.1:38640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-15T07:31:13.38226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.534034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.382717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.68342333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-15T07:31:13.382755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469416448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382778Z","caller":"traceutil/trace.go:171","msg":"trace[2145323153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"1.469465549s","start":"2026-04-15T07:31:11.913305Z","end":"2026-04-15T07:31:13.38277Z","steps":["trace[2145323153] 'agreement among raft nodes before linearized reading' (duration: 1.469439169s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.562799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382785Z","caller":"traceutil/trace.go:171","msg":"trace[1615259370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"1.683508572s","start":"2026-04-15T07:31:11.699261Z","end":"2026-04-15T07:31:13.38277Z","steps":["trace[1615259370] 'agreement among raft nodes before linearized reading' (duration: 1.683369338s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.699251Z","time spent":"1.683570454s","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-15T07:31:13.382762Z","caller":"traceutil/trace.go:171","msg":"trace[1801595150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:606; }","duration":"555.04372ms","start":"2026-04-15T07:31:12.827697Z","end":"2026-04-15T07:31:13.382741Z","steps":["trace[1801595150] 'agreement among raft nodes before linearized reading' (duration: 554.495572ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:13.382811Z","caller":"traceutil/trace.go:171","msg":"trace[1449596272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:606; }","duration":"285.60782ms","start":"2026-04-15T07:31:13.097195Z","end":"2026-04-15T07:31:13.382803Z","steps":["trace[1449596272] 'agreement among raft nodes before linearized reading' (duration: 285.570439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.893117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382928Z","caller":"traceutil/trace.go:171","msg":"trace[1055314252] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:606; }","duration":"530.935078ms","start":"2026-04-15T07:31:12.851985Z","end":"2026-04-15T07:31:13.38292Z","steps":["trace[1055314252] 'agreement among raft nodes before linearized reading' (duration: 530.891677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.851978Z","time spent":"530.966219ms","remote":"127.0.0.1:38640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-15T07:31:13.382731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.451902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.383054Z","caller":"traceutil/trace.go:171","msg":"trace[1436894774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:606; }","duration":"585.789842ms","start":"2026-04-15T07:31:12.797246Z","end":"2026-04-15T07:31:13.383036Z","steps":["trace[1436894774] 'agreement among raft nodes before linearized reading' (duration: 585.468113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.383126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.797228Z","time spent":"585.877104ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-15T07:31:13.383147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.781171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.383271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.825632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.382546Z","caller":"traceutil/trace.go:171","msg":"trace[386150489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:606; }","duration":"205.016842ms","start":"2026-04-15T07:31:13.177511Z","end":"2026-04-15T07:31:13.382528Z","steps":["trace[386150489] 'agreement among raft nodes before linearized reading' (duration: 204.864427ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:13.383339Z","caller":"traceutil/trace.go:171","msg":"trace[302874704] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:606; }","duration":"179.897215ms","start":"2026-04-15T07:31:13.203423Z","end":"2026-04-15T07:31:13.383321Z","steps":["trace[302874704] 'agreement among raft nodes before linearized reading' (duration: 179.823082ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:13.383286Z","caller":"traceutil/trace.go:171","msg":"trace[2074205677] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:606; }","duration":"178.999388ms","start":"2026-04-15T07:31:13.204266Z","end":"2026-04-15T07:31:13.383266Z","steps":["trace[2074205677] 'agreement among raft nodes before linearized reading' (duration: 178.704189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.383487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.125205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.382571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.582343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.383519Z","caller":"traceutil/trace.go:171","msg":"trace[1423825213] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:606; }","duration":"332.173576ms","start":"2026-04-15T07:31:13.051337Z","end":"2026-04-15T07:31:13.38351Z","steps":["trace[1423825213] 'agreement among raft nodes before linearized reading' (duration: 332.102684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.38362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:13.051332Z","time spent":"332.202767ms","remote":"127.0.0.1:38670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-15T07:31:13.383622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.912589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.383645Z","caller":"traceutil/trace.go:171","msg":"trace[1141658511] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:606; }","duration":"357.646555ms","start":"2026-04-15T07:31:13.025981Z","end":"2026-04-15T07:31:13.383628Z","steps":["trace[1141658511] 'agreement among raft nodes before linearized reading' (duration: 356.569593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.38372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:13.025971Z","time spent":"357.728058ms","remote":"127.0.0.1:38656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-15T07:31:13.383787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.062959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.383853Z","caller":"traceutil/trace.go:171","msg":"trace[1784298903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:606; }","duration":"556.153992ms","start":"2026-04-15T07:31:12.827681Z","end":"2026-04-15T07:31:13.383835Z","steps":["trace[1784298903] 'agreement among raft nodes before linearized reading' (duration: 556.057889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.383864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.426779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.383655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.827662Z","time spent":"555.967297ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-15T07:31:13.383918Z","caller":"traceutil/trace.go:171","msg":"trace[1694478695] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:606; }","duration":"180.480211ms","start":"2026-04-15T07:31:13.203407Z","end":"2026-04-15T07:31:13.383887Z","steps":["trace[1694478695] 'agreement among raft nodes before linearized reading' (duration: 180.42598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.383904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.82767Z","time spent":"556.218353ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-15T07:31:13.38245Z","caller":"traceutil/trace.go:171","msg":"trace[1332899966] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:606; }","duration":"204.235377ms","start":"2026-04-15T07:31:13.178129Z","end":"2026-04-15T07:31:13.382364Z","steps":["trace[1332899966] 'agreement among raft nodes before linearized reading' (duration: 203.963649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.973409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:13.382507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.988423Z","time spent":"394.073017ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-04-15T07:31:13.383667Z","caller":"traceutil/trace.go:171","msg":"trace[1521540889] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:606; }","duration":"331.997252ms","start":"2026-04-15T07:31:13.051658Z","end":"2026-04-15T07:31:13.383655Z","steps":["trace[1521540889] 'agreement among raft nodes before linearized reading' (duration: 331.365933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.384166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:13.051639Z","time spent":"332.515876ms","remote":"127.0.0.1:38670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-15T07:31:13.382797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.913278Z","time spent":"1.469515381s","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T07:31:13.382599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.159357ms","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-04-15T07:31:13.384311Z","caller":"traceutil/trace.go:171","msg":"trace[950162225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:606; }","duration":"206.892658ms","start":"2026-04-15T07:31:13.177401Z","end":"2026-04-15T07:31:13.384293Z","steps":["trace[950162225] 'agreement among raft nodes before linearized reading' (duration: 205.170268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690423759s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T07:31:13.384398Z","caller":"traceutil/trace.go:171","msg":"trace[539696714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"1.692262733s","start":"2026-04-15T07:31:11.692129Z","end":"2026-04-15T07:31:13.384392Z","steps":["trace[539696714] 'agreement among raft nodes before linearized reading' (duration: 1.690334955s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.384457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.692118Z","time spent":"1.692302324s","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T07:31:13.382633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.660126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.384519Z","caller":"traceutil/trace.go:171","msg":"trace[2022429306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:606; }","duration":"358.549291ms","start":"2026-04-15T07:31:13.025954Z","end":"2026-04-15T07:31:13.384503Z","steps":["trace[2022429306] 'agreement among raft nodes before linearized reading' (duration: 356.637725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.384581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:13.025949Z","time spent":"358.611993ms","remote":"127.0.0.1:38656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-15T07:31:13.382643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.563817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.384635Z","caller":"traceutil/trace.go:171","msg":"trace[1437585816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:606; }","duration":"586.617487ms","start":"2026-04-15T07:31:12.798009Z","end":"2026-04-15T07:31:13.384626Z","steps":["trace[1437585816] 'agreement among raft nodes before linearized reading' (duration: 584.592317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.384661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.797983Z","time spent":"586.668469ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-15T07:31:13.382642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.589571ms","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-04-15T07:31:13.384769Z","caller":"traceutil/trace.go:171","msg":"trace[1880434164] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:606; }","duration":"240.707415ms","start":"2026-04-15T07:31:13.144036Z","end":"2026-04-15T07:31:13.384744Z","steps":["trace[1880434164] 'agreement among raft nodes before linearized reading' (duration: 238.583732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.623516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.384913Z","caller":"traceutil/trace.go:171","msg":"trace[2117346156] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:606; }","duration":"395.874542ms","start":"2026-04-15T07:31:12.989016Z","end":"2026-04-15T07:31:13.38489Z","steps":["trace[2117346156] 'agreement among raft nodes before linearized reading' (duration: 393.631996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.385011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.989009Z","time spent":"395.977445ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-15T07:31:13.382677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.647704ms","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-04-15T07:31:13.385129Z","caller":"traceutil/trace.go:171","msg":"trace[660001889] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:606; }","duration":"241.103206ms","start":"2026-04-15T07:31:13.144009Z","end":"2026-04-15T07:31:13.385112Z","steps":["trace[660001889] 'agreement among raft nodes before linearized reading' (duration: 238.650434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.368279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.385327Z","caller":"traceutil/trace.go:171","msg":"trace[1196420225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:606; }","duration":"588.047639ms","start":"2026-04-15T07:31:12.797265Z","end":"2026-04-15T07:31:13.385313Z","steps":["trace[1196420225] 'agreement among raft nodes before linearized reading' (duration: 585.39321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.385397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.797241Z","time spent":"588.134072ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-15T07:31:13.382715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.068075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.385619Z","caller":"traceutil/trace.go:171","msg":"trace[109648139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:606; }","duration":"287.977481ms","start":"2026-04-15T07:31:13.097626Z","end":"2026-04-15T07:31:13.385603Z","steps":["trace[109648139] 'agreement among raft nodes before linearized reading' (duration: 285.067874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.382731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.036818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.386537Z","caller":"traceutil/trace.go:171","msg":"trace[1156755374] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:606; }","duration":"397.860701ms","start":"2026-04-15T07:31:12.988663Z","end":"2026-04-15T07:31:13.386523Z","steps":["trace[1156755374] 'agreement among raft nodes before linearized reading' (duration: 394.032927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.386574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.98865Z","time spent":"397.911073ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-15T07:31:13.382749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.309042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:13.386639Z","caller":"traceutil/trace.go:171","msg":"trace[267469095] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:606; }","duration":"289.199817ms","start":"2026-04-15T07:31:13.097431Z","end":"2026-04-15T07:31:13.38663Z","steps":["trace[267469095] 'agreement among raft nodes before linearized reading' (duration: 285.299541ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:13.384031Z","caller":"traceutil/trace.go:171","msg":"trace[1240272810] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:606; }","duration":"531.764212ms","start":"2026-04-15T07:31:12.852258Z","end":"2026-04-15T07:31:13.384022Z","steps":["trace[1240272810] 'agreement among raft nodes before linearized reading' (duration: 529.944588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.386705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:12.852253Z","time spent":"534.444153ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-15T07:31:13.382581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.683158692s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-15T07:31:13.386823Z","caller":"traceutil/trace.go:171","msg":"trace[1463119351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"1.68744572s","start":"2026-04-15T07:31:11.69937Z","end":"2026-04-15T07:31:13.386816Z","steps":["trace[1463119351] 'agreement among raft nodes before linearized reading' (duration: 1.683041908s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:13.386848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:11.699346Z","time spent":"1.68749447s","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T07:31:15.181749Z","caller":"traceutil/trace.go:171","msg":"trace[538883593] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"418.630343ms","start":"2026-04-15T07:31:14.763103Z","end":"2026-04-15T07:31:15.181733Z","steps":["trace[538883593] 'process raft request' (duration: 418.211131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:15.181925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:14.763076Z","time spent":"418.792309ms","remote":"127.0.0.1:60836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:31:15.184848Z","caller":"traceutil/trace.go:171","msg":"trace[539066924] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"331.458771ms","start":"2026-04-15T07:31:14.853377Z","end":"2026-04-15T07:31:15.184836Z","steps":["trace[539066924] 'process raft request' (duration: 331.201463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:15.184932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:14.853336Z","time spent":"331.573824ms","remote":"127.0.0.1:60794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:31:15.185206Z","caller":"traceutil/trace.go:171","msg":"trace[390892787] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"132.257945ms","start":"2026-04-15T07:31:15.052937Z","end":"2026-04-15T07:31:15.185195Z","steps":["trace[390892787] 'process raft request' (duration: 131.811191ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:15.18522Z","caller":"traceutil/trace.go:171","msg":"trace[1366829071] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"271.723033ms","start":"2026-04-15T07:31:14.913471Z","end":"2026-04-15T07:31:15.185194Z","steps":["trace[1366829071] 'read index received' (duration: 267.74498ms)","trace[1366829071] 'applied index is now lower than readState.Index' (duration: 3.976283ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:15.185613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.124625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:15.185758Z","caller":"traceutil/trace.go:171","msg":"trace[714514113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"272.226868ms","start":"2026-04-15T07:31:14.913438Z","end":"2026-04-15T07:31:15.185665Z","steps":["trace[714514113] 'agreement among raft nodes before linearized reading' (duration: 271.96624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:17.968881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.696009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-04-15T07:31:17.968975Z","caller":"traceutil/trace.go:171","msg":"trace[1241732318] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:696; }","duration":"118.848903ms","start":"2026-04-15T07:31:17.850102Z","end":"2026-04-15T07:31:17.968951Z","steps":["trace[1241732318] 'range keys from in-memory index tree' (duration: 118.527293ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:28.328894Z","caller":"traceutil/trace.go:171","msg":"trace[1708793963] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"415.640622ms","start":"2026-04-15T07:31:27.91323Z","end":"2026-04-15T07:31:28.32887Z","steps":["trace[1708793963] 'read index received' (duration: 415.481376ms)","trace[1708793963] 'applied index is now lower than readState.Index' (duration: 157.826µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:28.329076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.83508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:31:28.329212Z","caller":"traceutil/trace.go:171","msg":"trace[369302504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"416.032018ms","start":"2026-04-15T07:31:27.913159Z","end":"2026-04-15T07:31:28.329191Z","steps":["trace[369302504] 'agreement among raft nodes before linearized reading' (duration: 415.83408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:28.329269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:27.913147Z","time spent":"416.109741ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T07:31:28.329534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:27.89877Z","time spent":"430.17987ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-15T07:31:29.049221Z","caller":"traceutil/trace.go:171","msg":"trace[1717642331] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"718.114784ms","start":"2026-04-15T07:31:28.331073Z","end":"2026-04-15T07:31:29.049188Z","steps":["trace[1717642331] 'process raft request' (duration: 677.548523ms)","trace[1717642331] 'compare' (duration: 40.139514ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:31:29.049384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:28.331042Z","time spent":"718.252939ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:31:29.05363Z","caller":"traceutil/trace.go:171","msg":"trace[626780025] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:809; }","duration":"313.600258ms","start":"2026-04-15T07:31:28.740009Z","end":"2026-04-15T07:31:29.053609Z","steps":["trace[626780025] 'read index received' (duration: 268.709186ms)","trace[626780025] 'applied index is now lower than readState.Index' (duration: 44.890292ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:31:29.053667Z","caller":"traceutil/trace.go:171","msg":"trace[805493671] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"347.588781ms","start":"2026-04-15T07:31:28.706064Z","end":"2026-04-15T07:31:29.053653Z","steps":["trace[805493671] 'process raft request' (duration: 347.436884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:29.053734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:28.70604Z","time spent":"347.658934ms","remote":"127.0.0.1:32778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:31:29.053815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.799326ms","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-04-15T07:31:29.053845Z","caller":"traceutil/trace.go:171","msg":"trace[457957929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"313.904559ms","start":"2026-04-15T07:31:28.739933Z","end":"2026-04-15T07:31:29.053837Z","steps":["trace[457957929] 'agreement among raft nodes before linearized reading' (duration: 313.790565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:31:29.053811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.810006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:31:29.053865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:31:28.739903Z","time spent":"313.957211ms","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-15T07:31:29.053894Z","caller":"traceutil/trace.go:171","msg":"trace[2014099452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"139.916031ms","start":"2026-04-15T07:31:28.91395Z","end":"2026-04-15T07:31:29.053866Z","steps":["trace[2014099452] 'agreement among raft nodes before linearized reading' (duration: 139.801646ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:06.219201Z","caller":"traceutil/trace.go:171","msg":"trace[1003180079] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"144.607352ms","start":"2026-04-15T07:32:06.07456Z","end":"2026-04-15T07:32:06.219167Z","steps":["trace[1003180079] 'process raft request' (duration: 144.333697ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:42.17965Z","caller":"traceutil/trace.go:171","msg":"trace[731120866] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"111.875915ms","start":"2026-04-15T07:32:42.067752Z","end":"2026-04-15T07:32:42.179628Z","steps":["trace[731120866] 'process raft request' (duration: 86.913264ms)","trace[731120866] 'compare' (duration: 24.77681ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:32:42.180294Z","caller":"traceutil/trace.go:171","msg":"trace[1621197096] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"112.315653ms","start":"2026-04-15T07:32:42.067942Z","end":"2026-04-15T07:32:42.180257Z","steps":["trace[1621197096] 'process raft request' (duration: 111.657402ms)"],"step_count":1}