{"level":"warn","ts":"2026-09-22T01:51:16.541032Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T01:51:16.541124Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.193: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://162.253.55.193:2380","--initial-cluster=instance=https://162.253.55.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.193: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-09-22T01:51:16.541197Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T01:51:16.541216Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-22T01:51:16.541237Z","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-09-22T01:51:16.54205Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"]} {"level":"info","ts":"2026-09-22T01:51:16.542148Z","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://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.193: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-09-22T01:51:16.548665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.259202ms"} {"level":"info","ts":"2026-09-22T01:51:16.558955Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6814e3e3d6b4d713","cluster-id":"e5e99c9118b1492a"} {"level":"info","ts":"2026-09-22T01:51:16.55903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T01:51:16.559054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 0"} {"level":"info","ts":"2026-09-22T01:51:16.559063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6814e3e3d6b4d713 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T01:51:16.559073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 1"} {"level":"info","ts":"2026-09-22T01:51:16.559105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"warn","ts":"2026-09-22T01:51:16.56888Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T01:51:16.570646Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T01:51:16.572173Z","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-09-22T01:51:16.57452Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6814e3e3d6b4d713","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T01:51:16.574698Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6814e3e3d6b4d713","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T01:51:16.574852Z","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-09-22T01:51:16.574908Z","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-09-22T01:51:16.574919Z","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-09-22T01:51:16.575727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"info","ts":"2026-09-22T01:51:16.576021Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","added-peer-id":"6814e3e3d6b4d713","added-peer-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-22T01:51:16.579903Z","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-09-22T01:51:16.580058Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-22T01:51:16.580094Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-22T01:51:16.580233Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6814e3e3d6b4d713","initial-advertise-peer-urls":["https://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T01:51:16.580272Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T01:51:17.259772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T01:51:17.259827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T01:51:17.259873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgPreVoteResp from 6814e3e3d6b4d713 at term 1"} {"level":"info","ts":"2026-09-22T01:51:17.25989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became candidate at term 2"} {"level":"info","ts":"2026-09-22T01:51:17.2599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgVoteResp from 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-22T01:51:17.259915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became leader at term 2"} {"level":"info","ts":"2026-09-22T01:51:17.259927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6814e3e3d6b4d713 elected leader 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-22T01:51:17.261097Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6814e3e3d6b4d713","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.193:2379]}","request-path":"/0/members/6814e3e3d6b4d713/attributes","cluster-id":"e5e99c9118b1492a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T01:51:17.261165Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:51:17.261372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:51:17.261974Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:51:17.262099Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T01:51:17.262123Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T01:51:17.266306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T01:51:17.266697Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.193:2379"} {"level":"info","ts":"2026-09-22T01:51:17.269219Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:51:17.276237Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:51:17.276368Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-22T01:51:21.222133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.047776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:21.222251Z","caller":"traceutil/trace.go:171","msg":"trace[908514131] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"146.97928ms","start":"2026-09-22T01:51:21.075254Z","end":"2026-09-22T01:51:21.222233Z","steps":["trace[908514131] 'process raft request' (duration: 23.347363ms)","trace[908514131] 'compare' (duration: 122.92283ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:21.497478Z","caller":"traceutil/trace.go:171","msg":"trace[1552415444] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"249.569137ms","start":"2026-09-22T01:51:21.247879Z","end":"2026-09-22T01:51:21.497448Z","steps":["trace[1552415444] 'process raft request' (duration: 152.068492ms)","trace[1552415444] 'compare' (duration: 97.318056ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:21.680431Z","caller":"traceutil/trace.go:171","msg":"trace[845565579] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"171.697289ms","start":"2026-09-22T01:51:21.50871Z","end":"2026-09-22T01:51:21.680407Z","steps":["trace[845565579] 'read index received' (duration: 166.613467ms)","trace[845565579] 'applied index is now lower than readState.Index' (duration: 5.082682ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:21.680595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.815865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-22T01:51:21.680632Z","caller":"traceutil/trace.go:171","msg":"trace[1814777935] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:217; }","duration":"171.936521ms","start":"2026-09-22T01:51:21.508685Z","end":"2026-09-22T01:51:21.680621Z","steps":["trace[1814777935] 'agreement among raft nodes before linearized reading' (duration: 171.809664ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:21.680715Z","caller":"traceutil/trace.go:171","msg":"trace[1753545517] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"173.464142ms","start":"2026-09-22T01:51:21.507222Z","end":"2026-09-22T01:51:21.680686Z","steps":["trace[1753545517] 'process raft request' (duration: 168.013632ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:21.937803Z","caller":"traceutil/trace.go:171","msg":"trace[1049213261] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"176.272492ms","start":"2026-09-22T01:51:21.761505Z","end":"2026-09-22T01:51:21.937778Z","steps":["trace[1049213261] 'read index received' (duration: 132.756252ms)","trace[1049213261] 'applied index is now lower than readState.Index' (duration: 43.51516ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:21.938098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.562697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-22T01:51:21.938157Z","caller":"traceutil/trace.go:171","msg":"trace[1454243137] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:221; }","duration":"176.661362ms","start":"2026-09-22T01:51:21.761479Z","end":"2026-09-22T01:51:21.93814Z","steps":["trace[1454243137] 'agreement among raft nodes before linearized reading' (duration: 176.389458ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:21.938237Z","caller":"traceutil/trace.go:171","msg":"trace[1976879043] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"186.416642ms","start":"2026-09-22T01:51:21.751764Z","end":"2026-09-22T01:51:21.93818Z","steps":["trace[1976879043] 'process raft request' (duration: 142.562615ms)","trace[1976879043] 'compare' (duration: 43.323048ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:22.917483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.478735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:22.917651Z","caller":"traceutil/trace.go:171","msg":"trace[818124802] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:229; }","duration":"820.172174ms","start":"2026-09-22T01:51:22.097461Z","end":"2026-09-22T01:51:22.917633Z","steps":["trace[818124802] 'read index received' (duration: 119.473048ms)","trace[818124802] 'applied index is now lower than readState.Index' (duration: 700.697486ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:22.917761Z","caller":"traceutil/trace.go:171","msg":"trace[1693387937] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"894.998809ms","start":"2026-09-22T01:51:22.022742Z","end":"2026-09-22T01:51:22.917741Z","steps":["trace[1693387937] 'process raft request' (duration: 194.184457ms)","trace[1693387937] 'compare' (duration: 700.341727ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:22.917868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.022723Z","time spent":"895.115225ms","remote":"127.0.0.1:60718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T01:51:22.918301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.304568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-09-22T01:51:22.918384Z","caller":"traceutil/trace.go:171","msg":"trace[122165020] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:224; }","duration":"396.416124ms","start":"2026-09-22T01:51:22.521955Z","end":"2026-09-22T01:51:22.918371Z","steps":["trace[122165020] 'agreement among raft nodes before linearized reading' (duration: 396.301718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:22.918437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.521932Z","time spent":"396.495298ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3732,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-09-22T01:51:22.918296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.819159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:22.918684Z","caller":"traceutil/trace.go:171","msg":"trace[1462841415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:224; }","duration":"821.126485ms","start":"2026-09-22T01:51:22.097455Z","end":"2026-09-22T01:51:22.918581Z","steps":["trace[1462841415] 'agreement among raft nodes before linearized reading' (duration: 820.766346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:22.918876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.097416Z","time spent":"821.362968ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-22T01:51:22.919247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.892162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:22.919991Z","caller":"traceutil/trace.go:171","msg":"trace[584820938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:224; }","duration":"110.56239ms","start":"2026-09-22T01:51:22.809403Z","end":"2026-09-22T01:51:22.919965Z","steps":["trace[584820938] 'agreement among raft nodes before linearized reading' (duration: 108.86548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.391842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.178782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:23.39214Z","caller":"traceutil/trace.go:171","msg":"trace[324910140] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"468.115407ms","start":"2026-09-22T01:51:22.923992Z","end":"2026-09-22T01:51:23.392108Z","steps":["trace[324910140] 'process raft request' (duration: 121.591756ms)","trace[324910140] 'compare' (duration: 345.712848ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:23.392199Z","caller":"traceutil/trace.go:171","msg":"trace[1639145832] linearizableReadLoop","detail":"{readStateIndex:232; appliedIndex:230; }","duration":"466.715622ms","start":"2026-09-22T01:51:22.925413Z","end":"2026-09-22T01:51:23.392129Z","steps":["trace[1639145832] 'read index received' (duration: 27.946959ms)","trace[1639145832] 'applied index is now lower than readState.Index' (duration: 438.767633ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:23.39252Z","caller":"traceutil/trace.go:171","msg":"trace[1266824060] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"463.761954ms","start":"2026-09-22T01:51:22.928747Z","end":"2026-09-22T01:51:23.392509Z","steps":["trace[1266824060] 'process raft request' (duration: 463.262148ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.39264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.197029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:51:23.392271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.923975Z","time spent":"468.257164ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T01:51:23.392719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.904555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:51:23.392698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.662078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-22T01:51:23.392773Z","caller":"traceutil/trace.go:171","msg":"trace[1380326373] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:227; }","duration":"467.376779ms","start":"2026-09-22T01:51:22.925366Z","end":"2026-09-22T01:51:23.392743Z","steps":["trace[1380326373] 'agreement among raft nodes before linearized reading' (duration: 467.151876ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:23.392799Z","caller":"traceutil/trace.go:171","msg":"trace[1595574659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:227; }","duration":"308.007991ms","start":"2026-09-22T01:51:23.084746Z","end":"2026-09-22T01:51:23.392754Z","steps":["trace[1595574659] 'agreement among raft nodes before linearized reading' (duration: 307.895625ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.392726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.867259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-22T01:51:23.392845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.925345Z","time spent":"467.484514ms","remote":"127.0.0.1:60718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-09-22T01:51:23.392842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:23.084725Z","time spent":"308.106866ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T01:51:23.393078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.928734Z","time spent":"463.899813ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:23.39308Z","caller":"traceutil/trace.go:171","msg":"trace[1553442969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:227; }","duration":"435.828067ms","start":"2026-09-22T01:51:22.956942Z","end":"2026-09-22T01:51:23.39277Z","steps":["trace[1553442969] 'agreement among raft nodes before linearized reading' (duration: 435.596574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.393227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.956918Z","time spent":"436.293652ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-22T01:51:23.3933Z","caller":"traceutil/trace.go:171","msg":"trace[937604821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:227; }","duration":"417.045468ms","start":"2026-09-22T01:51:22.975823Z","end":"2026-09-22T01:51:23.392869Z","steps":["trace[937604821] 'agreement among raft nodes before linearized reading' (duration: 416.853818ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.393377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:22.975811Z","time spent":"417.547745ms","remote":"127.0.0.1:60782","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":"info","ts":"2026-09-22T01:51:23.5552Z","caller":"traceutil/trace.go:171","msg":"trace[522136282] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"156.777656ms","start":"2026-09-22T01:51:23.398387Z","end":"2026-09-22T01:51:23.555165Z","steps":["trace[522136282] 'process raft request' (duration: 107.927068ms)","trace[522136282] 'compare' (duration: 48.7027ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:23.555309Z","caller":"traceutil/trace.go:171","msg":"trace[622278193] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"156.567274ms","start":"2026-09-22T01:51:23.3987Z","end":"2026-09-22T01:51:23.555267Z","steps":["trace[622278193] 'process raft request' (duration: 156.412076ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:23.555455Z","caller":"traceutil/trace.go:171","msg":"trace[16584981] linearizableReadLoop","detail":"{readStateIndex:235; appliedIndex:233; }","duration":"156.88251ms","start":"2026-09-22T01:51:23.398523Z","end":"2026-09-22T01:51:23.555406Z","steps":["trace[16584981] 'read index received' (duration: 61.163462ms)","trace[16584981] 'applied index is now lower than readState.Index' (duration: 95.717688ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:23.555592Z","caller":"traceutil/trace.go:171","msg":"trace[488332872] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"154.256959ms","start":"2026-09-22T01:51:23.40132Z","end":"2026-09-22T01:51:23.555577Z","steps":["trace[488332872] 'process raft request' (duration: 153.991274ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:23.555578Z","caller":"traceutil/trace.go:171","msg":"trace[1578745761] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"154.28282ms","start":"2026-09-22T01:51:23.401272Z","end":"2026-09-22T01:51:23.555555Z","steps":["trace[1578745761] 'process raft request' (duration: 153.877849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.555667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.077371ms","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-09-22T01:51:23.55571Z","caller":"traceutil/trace.go:171","msg":"trace[918762672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:232; }","duration":"158.100637ms","start":"2026-09-22T01:51:23.397598Z","end":"2026-09-22T01:51:23.555699Z","steps":["trace[918762672] 'agreement among raft nodes before linearized reading' (duration: 157.917517ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:23.592425Z","caller":"traceutil/trace.go:171","msg":"trace[1582841701] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"100.814414ms","start":"2026-09-22T01:51:23.491593Z","end":"2026-09-22T01:51:23.592407Z","steps":["trace[1582841701] 'process raft request' (duration: 100.706628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:23.882494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.343718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:23.882757Z","caller":"traceutil/trace.go:171","msg":"trace[327631861] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"271.749843ms","start":"2026-09-22T01:51:23.610977Z","end":"2026-09-22T01:51:23.882727Z","steps":["trace[327631861] 'process raft request' (duration: 131.113019ms)","trace[327631861] 'compare' (duration: 140.20727ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:23.882839Z","caller":"traceutil/trace.go:171","msg":"trace[364897304] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"227.166677ms","start":"2026-09-22T01:51:23.655637Z","end":"2026-09-22T01:51:23.882804Z","steps":["trace[364897304] 'process raft request' (duration: 226.950855ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:23.88269Z","caller":"traceutil/trace.go:171","msg":"trace[266454216] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"223.323859ms","start":"2026-09-22T01:51:23.659349Z","end":"2026-09-22T01:51:23.882673Z","steps":["trace[266454216] 'process raft request' (duration: 223.281407ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:24.049474Z","caller":"traceutil/trace.go:171","msg":"trace[829582090] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"107.135381ms","start":"2026-09-22T01:51:23.942313Z","end":"2026-09-22T01:51:24.049448Z","steps":["trace[829582090] 'process raft request' (duration: 100.87773ms)"],"step_count":1} 2026/09/22 01:51:24 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-09-22T01:51:25.74022Z","caller":"traceutil/trace.go:171","msg":"trace[1266983357] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"130.54785ms","start":"2026-09-22T01:51:25.609639Z","end":"2026-09-22T01:51:25.740186Z","steps":["trace[1266983357] 'process raft request' (duration: 128.313588ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.740322Z","caller":"traceutil/trace.go:171","msg":"trace[570838130] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"110.571468ms","start":"2026-09-22T01:51:25.629726Z","end":"2026-09-22T01:51:25.740297Z","steps":["trace[570838130] 'process raft request' (duration: 110.455241ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.740355Z","caller":"traceutil/trace.go:171","msg":"trace[9827424] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"130.492286ms","start":"2026-09-22T01:51:25.609836Z","end":"2026-09-22T01:51:25.740328Z","steps":["trace[9827424] 'process raft request' (duration: 130.277055ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.740276Z","caller":"traceutil/trace.go:171","msg":"trace[1381769395] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"130.473985ms","start":"2026-09-22T01:51:25.609781Z","end":"2026-09-22T01:51:25.740255Z","steps":["trace[1381769395] 'process raft request' (duration: 130.304216ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.926116Z","caller":"traceutil/trace.go:171","msg":"trace[2114193771] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"110.334915ms","start":"2026-09-22T01:51:25.815755Z","end":"2026-09-22T01:51:25.92609Z","steps":["trace[2114193771] 'read index received' (duration: 75.31686ms)","trace[2114193771] 'applied index is now lower than readState.Index' (duration: 35.016885ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:25.926374Z","caller":"traceutil/trace.go:171","msg":"trace[936597079] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"126.431944ms","start":"2026-09-22T01:51:25.799907Z","end":"2026-09-22T01:51:25.926339Z","steps":["trace[936597079] 'process raft request' (duration: 91.163066ms)","trace[936597079] 'compare' (duration: 34.911519ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:25.926505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.454772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-09-22T01:51:25.926555Z","caller":"traceutil/trace.go:171","msg":"trace[1797279953] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:325; }","duration":"123.541136ms","start":"2026-09-22T01:51:25.802998Z","end":"2026-09-22T01:51:25.92654Z","steps":["trace[1797279953] 'agreement among raft nodes before linearized reading' (duration: 123.450711ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.93279Z","caller":"traceutil/trace.go:171","msg":"trace[1601457294] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"112.251209ms","start":"2026-09-22T01:51:25.820522Z","end":"2026-09-22T01:51:25.932773Z","steps":["trace[1601457294] 'process raft request' (duration: 111.957123ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.932758Z","caller":"traceutil/trace.go:171","msg":"trace[44810453] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"110.407518ms","start":"2026-09-22T01:51:25.822319Z","end":"2026-09-22T01:51:25.932726Z","steps":["trace[44810453] 'process raft request' (duration: 110.324754ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.174013Z","caller":"traceutil/trace.go:171","msg":"trace[647977973] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"232.760037ms","start":"2026-09-22T01:51:25.941227Z","end":"2026-09-22T01:51:26.173987Z","steps":["trace[647977973] 'process raft request' (duration: 147.023579ms)","trace[647977973] 'compare' (duration: 85.560288ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:26.174296Z","caller":"traceutil/trace.go:171","msg":"trace[2086452858] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:340; }","duration":"220.908029ms","start":"2026-09-22T01:51:25.953215Z","end":"2026-09-22T01:51:26.174123Z","steps":["trace[2086452858] 'read index received' (duration: 9.896691ms)","trace[2086452858] 'applied index is now lower than readState.Index' (duration: 211.008178ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:26.17431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.072158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-22T01:51:26.17436Z","caller":"traceutil/trace.go:171","msg":"trace[724827105] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"207.936879ms","start":"2026-09-22T01:51:25.966412Z","end":"2026-09-22T01:51:26.174349Z","steps":["trace[724827105] 'process raft request' (duration: 207.819703ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.174398Z","caller":"traceutil/trace.go:171","msg":"trace[555897688] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:329; }","duration":"221.199745ms","start":"2026-09-22T01:51:25.953178Z","end":"2026-09-22T01:51:26.174377Z","steps":["trace[555897688] 'agreement among raft nodes before linearized reading' (duration: 221.031236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.530457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4134"} {"level":"info","ts":"2026-09-22T01:51:26.174808Z","caller":"traceutil/trace.go:171","msg":"trace[1348632840] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:330; }","duration":"129.851066ms","start":"2026-09-22T01:51:26.044943Z","end":"2026-09-22T01:51:26.174794Z","steps":["trace[1348632840] 'agreement among raft nodes before linearized reading' (duration: 129.514396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.997639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-09-22T01:51:26.174921Z","caller":"traceutil/trace.go:171","msg":"trace[1172281695] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:330; }","duration":"171.459566ms","start":"2026-09-22T01:51:26.003446Z","end":"2026-09-22T01:51:26.174906Z","steps":["trace[1172281695] 'agreement among raft nodes before linearized reading' (duration: 170.969858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.525307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-09-22T01:51:26.175027Z","caller":"traceutil/trace.go:171","msg":"trace[970778572] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:330; }","duration":"130.085009ms","start":"2026-09-22T01:51:26.044931Z","end":"2026-09-22T01:51:26.175016Z","steps":["trace[970778572] 'agreement among raft nodes before linearized reading' (duration: 129.497006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.591531ms","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-09-22T01:51:26.175116Z","caller":"traceutil/trace.go:171","msg":"trace[1676118331] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:330; }","duration":"130.170433ms","start":"2026-09-22T01:51:26.044931Z","end":"2026-09-22T01:51:26.175101Z","steps":["trace[1676118331] 'agreement among raft nodes before linearized reading' (duration: 129.605762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.306505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-22T01:51:26.175259Z","caller":"traceutil/trace.go:171","msg":"trace[1501274539] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:330; }","duration":"121.997053ms","start":"2026-09-22T01:51:26.053253Z","end":"2026-09-22T01:51:26.17525Z","steps":["trace[1501274539] 'agreement among raft nodes before linearized reading' (duration: 121.301505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.683525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-09-22T01:51:26.175333Z","caller":"traceutil/trace.go:171","msg":"trace[277285175] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:330; }","duration":"130.450169ms","start":"2026-09-22T01:51:26.044877Z","end":"2026-09-22T01:51:26.175327Z","steps":["trace[277285175] 'agreement among raft nodes before linearized reading' (duration: 129.674025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.650434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-09-22T01:51:26.175402Z","caller":"traceutil/trace.go:171","msg":"trace[859797634] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:330; }","duration":"130.464249ms","start":"2026-09-22T01:51:26.044933Z","end":"2026-09-22T01:51:26.175397Z","steps":["trace[859797634] 'agreement among raft nodes before linearized reading' (duration: 129.658955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.596101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-09-22T01:51:26.175482Z","caller":"traceutil/trace.go:171","msg":"trace[2146298910] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:330; }","duration":"130.460889ms","start":"2026-09-22T01:51:26.045016Z","end":"2026-09-22T01:51:26.175476Z","steps":["trace[2146298910] 'agreement among raft nodes before linearized reading' (duration: 129.58626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.174619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.643894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-09-22T01:51:26.175565Z","caller":"traceutil/trace.go:171","msg":"trace[1072552871] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:330; }","duration":"130.648689ms","start":"2026-09-22T01:51:26.044913Z","end":"2026-09-22T01:51:26.175561Z","steps":["trace[1072552871] 'agreement among raft nodes before linearized reading' (duration: 129.612322ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.536885Z","caller":"traceutil/trace.go:171","msg":"trace[793133525] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"168.722254ms","start":"2026-09-22T01:51:26.367818Z","end":"2026-09-22T01:51:26.53654Z","steps":["trace[793133525] 'process raft request' (duration: 98.663879ms)","trace[793133525] 'compare' (duration: 69.928278ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:26.546514Z","caller":"traceutil/trace.go:171","msg":"trace[2015198355] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"165.72626ms","start":"2026-09-22T01:51:26.380764Z","end":"2026-09-22T01:51:26.54649Z","steps":["trace[2015198355] 'process raft request' (duration: 165.583252ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.546539Z","caller":"traceutil/trace.go:171","msg":"trace[956906485] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"165.55423ms","start":"2026-09-22T01:51:26.380965Z","end":"2026-09-22T01:51:26.546519Z","steps":["trace[956906485] 'process raft request' (duration: 165.432034ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.546524Z","caller":"traceutil/trace.go:171","msg":"trace[569110927] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:350; }","duration":"142.777967ms","start":"2026-09-22T01:51:26.403723Z","end":"2026-09-22T01:51:26.546501Z","steps":["trace[569110927] 'read index received' (duration: 62.761034ms)","trace[569110927] 'applied index is now lower than readState.Index' (duration: 80.016043ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:26.546728Z","caller":"traceutil/trace.go:171","msg":"trace[449912721] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"165.603063ms","start":"2026-09-22T01:51:26.381091Z","end":"2026-09-22T01:51:26.546694Z","steps":["trace[449912721] 'process raft request' (duration: 165.37217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.546991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.216141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-22T01:51:26.547097Z","caller":"traceutil/trace.go:171","msg":"trace[278474020] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"143.373679ms","start":"2026-09-22T01:51:26.403685Z","end":"2026-09-22T01:51:26.547059Z","steps":["trace[278474020] 'agreement among raft nodes before linearized reading' (duration: 143.093444ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.547522Z","caller":"traceutil/trace.go:171","msg":"trace[198360671] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"168.606359ms","start":"2026-09-22T01:51:26.378899Z","end":"2026-09-22T01:51:26.547506Z","steps":["trace[198360671] 'process raft request' (duration: 167.314418ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.823724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.821533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:26.82401Z","caller":"traceutil/trace.go:171","msg":"trace[1769531891] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"268.528497ms","start":"2026-09-22T01:51:26.555455Z","end":"2026-09-22T01:51:26.823983Z","steps":["trace[1769531891] 'process raft request' (duration: 158.350004ms)","trace[1769531891] 'compare' (duration: 109.640893ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:26.824022Z","caller":"traceutil/trace.go:171","msg":"trace[1328453359] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"267.408495ms","start":"2026-09-22T01:51:26.556594Z","end":"2026-09-22T01:51:26.824002Z","steps":["trace[1328453359] 'process raft request' (duration: 267.274137ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.824175Z","caller":"traceutil/trace.go:171","msg":"trace[664372798] transaction","detail":"{read_only:false; number_of_response:1; response_revision:346; }","duration":"264.385968ms","start":"2026-09-22T01:51:26.559783Z","end":"2026-09-22T01:51:26.824169Z","steps":["trace[664372798] 'process raft request' (duration: 264.199728ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.824297Z","caller":"traceutil/trace.go:171","msg":"trace[95797947] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"264.59202ms","start":"2026-09-22T01:51:26.559684Z","end":"2026-09-22T01:51:26.824276Z","steps":["trace[95797947] 'process raft request' (duration: 264.254642ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.824349Z","caller":"traceutil/trace.go:171","msg":"trace[1378127919] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"260.852274ms","start":"2026-09-22T01:51:26.563461Z","end":"2026-09-22T01:51:26.824313Z","steps":["trace[1378127919] 'process raft request' (duration: 260.76225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:26.824493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.204874ms","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-09-22T01:51:26.824538Z","caller":"traceutil/trace.go:171","msg":"trace[10349082] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"260.895307ms","start":"2026-09-22T01:51:26.563635Z","end":"2026-09-22T01:51:26.824531Z","steps":["trace[10349082] 'process raft request' (duration: 260.641913ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.824541Z","caller":"traceutil/trace.go:171","msg":"trace[483060548] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:349; }","duration":"267.289799ms","start":"2026-09-22T01:51:26.557236Z","end":"2026-09-22T01:51:26.824526Z","steps":["trace[483060548] 'agreement among raft nodes before linearized reading' (duration: 267.205424ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:26.824418Z","caller":"traceutil/trace.go:171","msg":"trace[402310421] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:355; }","duration":"267.135331ms","start":"2026-09-22T01:51:26.557271Z","end":"2026-09-22T01:51:26.824406Z","steps":["trace[402310421] 'read index received' (duration: 7.898294ms)","trace[402310421] 'applied index is now lower than readState.Index' (duration: 259.235996ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:26.824337Z","caller":"traceutil/trace.go:171","msg":"trace[923173121] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"263.275977ms","start":"2026-09-22T01:51:26.561055Z","end":"2026-09-22T01:51:26.824331Z","steps":["trace[923173121] 'process raft request' (duration: 262.974161ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.222369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.664785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:27.222903Z","caller":"traceutil/trace.go:171","msg":"trace[981927279] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"383.236262ms","start":"2026-09-22T01:51:26.839631Z","end":"2026-09-22T01:51:27.222868Z","steps":["trace[981927279] 'process raft request' (duration: 165.976185ms)","trace[981927279] 'compare' (duration: 216.381748ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:27.223073Z","caller":"traceutil/trace.go:171","msg":"trace[1406397258] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"381.794132ms","start":"2026-09-22T01:51:26.841244Z","end":"2026-09-22T01:51:27.223038Z","steps":["trace[1406397258] 'process raft request' (duration: 381.257682ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.223163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:26.841225Z","time spent":"381.909478ms","remote":"127.0.0.1:60704","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-09-22T01:51:27.223355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:26.839611Z","time spent":"383.37294ms","remote":"127.0.0.1:60614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:51:27.223657Z","caller":"traceutil/trace.go:171","msg":"trace[1969765383] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:363; }","duration":"382.437358ms","start":"2026-09-22T01:51:26.841206Z","end":"2026-09-22T01:51:27.223643Z","steps":["trace[1969765383] 'read index received' (duration: 995.454µs)","trace[1969765383] 'applied index is now lower than readState.Index' (duration: 381.439924ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:27.223798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.579147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-09-22T01:51:27.223836Z","caller":"traceutil/trace.go:171","msg":"trace[954187537] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:351; }","duration":"382.674432ms","start":"2026-09-22T01:51:26.841151Z","end":"2026-09-22T01:51:27.223826Z","steps":["trace[954187537] 'agreement among raft nodes before linearized reading' (duration: 382.538334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.22386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:26.841125Z","time spent":"382.729625ms","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6988,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-09-22T01:51:27.239402Z","caller":"traceutil/trace.go:171","msg":"trace[1927115891] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"395.705274ms","start":"2026-09-22T01:51:26.843678Z","end":"2026-09-22T01:51:27.239383Z","steps":["trace[1927115891] 'process raft request' (duration: 395.643071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.23954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:26.843664Z","time spent":"395.796259ms","remote":"127.0.0.1:60964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:27.239827Z","caller":"traceutil/trace.go:171","msg":"trace[1991800990] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"397.329713ms","start":"2026-09-22T01:51:26.842453Z","end":"2026-09-22T01:51:27.239783Z","steps":["trace[1991800990] 'process raft request' (duration: 396.772642ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.239886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:26.842419Z","time spent":"397.441589ms","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:51:27.521796Z","caller":"traceutil/trace.go:171","msg":"trace[1804311384] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:372; }","duration":"223.219638ms","start":"2026-09-22T01:51:27.298557Z","end":"2026-09-22T01:51:27.521777Z","steps":["trace[1804311384] 'read index received' (duration: 168.734191ms)","trace[1804311384] 'applied index is now lower than readState.Index' (duration: 54.484507ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:27.521901Z","caller":"traceutil/trace.go:171","msg":"trace[1505965492] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"270.053911ms","start":"2026-09-22T01:51:27.251837Z","end":"2026-09-22T01:51:27.521891Z","steps":["trace[1505965492] 'process raft request' (duration: 215.436387ms)","trace[1505965492] 'compare' (duration: 54.249463ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:27.522095Z","caller":"traceutil/trace.go:171","msg":"trace[12918966] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"263.495568ms","start":"2026-09-22T01:51:27.258591Z","end":"2026-09-22T01:51:27.522087Z","steps":["trace[12918966] 'process raft request' (duration: 263.039382ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.522378Z","caller":"traceutil/trace.go:171","msg":"trace[1026167035] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"262.356784ms","start":"2026-09-22T01:51:27.260011Z","end":"2026-09-22T01:51:27.522368Z","steps":["trace[1026167035] 'process raft request' (duration: 261.647624ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.522494Z","caller":"traceutil/trace.go:171","msg":"trace[1256684146] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"253.97266ms","start":"2026-09-22T01:51:27.268514Z","end":"2026-09-22T01:51:27.522486Z","steps":["trace[1256684146] 'process raft request' (duration: 253.182236ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.52267Z","caller":"traceutil/trace.go:171","msg":"trace[1537221430] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"225.420959ms","start":"2026-09-22T01:51:27.297241Z","end":"2026-09-22T01:51:27.522662Z","steps":["trace[1537221430] 'process raft request' (duration: 224.501539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.522821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.246405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-09-22T01:51:27.522859Z","caller":"traceutil/trace.go:171","msg":"trace[596866390] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:363; }","duration":"224.320988ms","start":"2026-09-22T01:51:27.298527Z","end":"2026-09-22T01:51:27.522848Z","steps":["trace[596866390] 'agreement among raft nodes before linearized reading' (duration: 224.247514ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.523006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.435125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-bk2tq\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-09-22T01:51:27.523065Z","caller":"traceutil/trace.go:171","msg":"trace[292983763] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-bk2tq; range_end:; response_count:1; response_revision:363; }","duration":"224.549151ms","start":"2026-09-22T01:51:27.298505Z","end":"2026-09-22T01:51:27.523054Z","steps":["trace[292983763] 'agreement among raft nodes before linearized reading' (duration: 224.469366ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.739732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.534999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:27.739824Z","caller":"traceutil/trace.go:171","msg":"trace[640625478] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"207.296246ms","start":"2026-09-22T01:51:27.532507Z","end":"2026-09-22T01:51:27.739803Z","steps":["trace[640625478] 'read index received' (duration: 96.612119ms)","trace[640625478] 'applied index is now lower than readState.Index' (duration: 110.683077ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:27.739893Z","caller":"traceutil/trace.go:171","msg":"trace[1601031015] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"207.483926ms","start":"2026-09-22T01:51:27.532398Z","end":"2026-09-22T01:51:27.739882Z","steps":["trace[1601031015] 'process raft request' (duration: 96.707704ms)","trace[1601031015] 'compare' (duration: 110.397122ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:27.740046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.537079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-09-22T01:51:27.740078Z","caller":"traceutil/trace.go:171","msg":"trace[325218162] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:364; }","duration":"207.609613ms","start":"2026-09-22T01:51:27.532459Z","end":"2026-09-22T01:51:27.740068Z","steps":["trace[325218162] 'agreement among raft nodes before linearized reading' (duration: 207.548479ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.750914Z","caller":"traceutil/trace.go:171","msg":"trace[1629985378] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"218.259623ms","start":"2026-09-22T01:51:27.532634Z","end":"2026-09-22T01:51:27.750894Z","steps":["trace[1629985378] 'process raft request' (duration: 218.124616ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.751113Z","caller":"traceutil/trace.go:171","msg":"trace[2071239598] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"218.3713ms","start":"2026-09-22T01:51:27.532725Z","end":"2026-09-22T01:51:27.751096Z","steps":["trace[2071239598] 'process raft request' (duration: 218.131196ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.751174Z","caller":"traceutil/trace.go:171","msg":"trace[1803092532] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"218.352018ms","start":"2026-09-22T01:51:27.532796Z","end":"2026-09-22T01:51:27.751148Z","steps":["trace[1803092532] 'process raft request' (duration: 218.185959ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.751434Z","caller":"traceutil/trace.go:171","msg":"trace[915702053] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"216.588911ms","start":"2026-09-22T01:51:27.534833Z","end":"2026-09-22T01:51:27.751421Z","steps":["trace[915702053] 'process raft request' (duration: 216.22443ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.751671Z","caller":"traceutil/trace.go:171","msg":"trace[8836427] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"214.612542ms","start":"2026-09-22T01:51:27.537037Z","end":"2026-09-22T01:51:27.75165Z","steps":["trace[8836427] 'process raft request' (duration: 214.076302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.751722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.423531ms","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-09-22T01:51:27.75176Z","caller":"traceutil/trace.go:171","msg":"trace[1111239934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:369; }","duration":"171.496595ms","start":"2026-09-22T01:51:27.580252Z","end":"2026-09-22T01:51:27.751748Z","steps":["trace[1111239934] 'agreement among raft nodes before linearized reading' (duration: 171.40204ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.932118Z","caller":"traceutil/trace.go:171","msg":"trace[834175773] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"184.279323ms","start":"2026-09-22T01:51:27.747805Z","end":"2026-09-22T01:51:27.932084Z","steps":["trace[834175773] 'process raft request' (duration: 113.314564ms)","trace[834175773] 'compare' (duration: 70.668942ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:27.932265Z","caller":"traceutil/trace.go:171","msg":"trace[1958358308] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"175.770381ms","start":"2026-09-22T01:51:27.756471Z","end":"2026-09-22T01:51:27.932242Z","steps":["trace[1958358308] 'process raft request' (duration: 175.661425ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.932391Z","caller":"traceutil/trace.go:171","msg":"trace[281674574] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"175.93426ms","start":"2026-09-22T01:51:27.756435Z","end":"2026-09-22T01:51:27.93237Z","steps":["trace[281674574] 'process raft request' (duration: 175.616563ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.932577Z","caller":"traceutil/trace.go:171","msg":"trace[123742684] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"180.961758ms","start":"2026-09-22T01:51:27.751606Z","end":"2026-09-22T01:51:27.932568Z","steps":["trace[123742684] 'read index received' (duration: 109.45664ms)","trace[123742684] 'applied index is now lower than readState.Index' (duration: 71.503398ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:27.932706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.33488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"warn","ts":"2026-09-22T01:51:27.932724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.727102ms","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-09-22T01:51:27.932758Z","caller":"traceutil/trace.go:171","msg":"trace[497231965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:372; }","duration":"185.816777ms","start":"2026-09-22T01:51:27.746933Z","end":"2026-09-22T01:51:27.93275Z","steps":["trace[497231965] 'agreement among raft nodes before linearized reading' (duration: 185.719862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:27.932744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.669551ms","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-09-22T01:51:27.932761Z","caller":"traceutil/trace.go:171","msg":"trace[1323337823] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:372; }","duration":"185.469107ms","start":"2026-09-22T01:51:27.747278Z","end":"2026-09-22T01:51:27.932747Z","steps":["trace[1323337823] 'agreement among raft nodes before linearized reading' (duration: 185.34567ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:27.932791Z","caller":"traceutil/trace.go:171","msg":"trace[2003237292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:372; }","duration":"148.725074ms","start":"2026-09-22T01:51:27.784052Z","end":"2026-09-22T01:51:27.932777Z","steps":["trace[2003237292] 'agreement among raft nodes before linearized reading' (duration: 148.622808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:29.800933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168806706s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:29.801037Z","caller":"traceutil/trace.go:171","msg":"trace[1967731089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:376; }","duration":"1.168940014s","start":"2026-09-22T01:51:28.632058Z","end":"2026-09-22T01:51:29.800998Z","steps":["trace[1967731089] 'range keys from in-memory index tree' (duration: 1.168709011s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:29.801085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:28.632034Z","time spent":"1.169040169s","remote":"127.0.0.1:60484","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-09-22T01:51:29.801071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.903286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:29.801243Z","caller":"traceutil/trace.go:171","msg":"trace[1770122855] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"736.599659ms","start":"2026-09-22T01:51:29.064617Z","end":"2026-09-22T01:51:29.801217Z","steps":["trace[1770122855] 'process raft request' (duration: 378.453128ms)","trace[1770122855] 'compare' (duration: 357.442861ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:29.801427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.064594Z","time spent":"736.745657ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:30.310417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907518455698003,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-22T01:51:30.810598Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907518455698003,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-22T01:51:31.609215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.660828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:31.609348Z","caller":"traceutil/trace.go:171","msg":"trace[439648129] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"1.803521269s","start":"2026-09-22T01:51:29.805778Z","end":"2026-09-22T01:51:31.609299Z","steps":["trace[439648129] 'process raft request' (duration: 1.162697012s)","trace[439648129] 'compare' (duration: 640.539821ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:31.609413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.80576Z","time spent":"1.803626255s","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:31.810003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000216622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-09-22T01:51:31.810088Z","caller":"traceutil/trace.go:171","msg":"trace[1585849327] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000345469s","start":"2026-09-22T01:51:29.809724Z","end":"2026-09-22T01:51:31.810069Z","steps":["trace[1585849327] 'agreement among raft nodes before linearized reading' (duration: 2.000231163s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:31.810302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.809715Z","time spent":"2.000573663s","remote":"127.0.0.1:60484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/09/22 01:51:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-09-22T01:51:31.91882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.103019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:31.91896Z","caller":"traceutil/trace.go:171","msg":"trace[792243107] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:391; }","duration":"2.109187095s","start":"2026-09-22T01:51:29.809745Z","end":"2026-09-22T01:51:31.918932Z","steps":["trace[792243107] 'read index received' (duration: 1.158718328s)","trace[792243107] 'applied index is now lower than readState.Index' (duration: 950.464297ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:31.918989Z","caller":"traceutil/trace.go:171","msg":"trace[52315535] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"2.105107797s","start":"2026-09-22T01:51:29.813856Z","end":"2026-09-22T01:51:31.918964Z","steps":["trace[52315535] 'process raft request' (duration: 1.902759675s)","trace[52315535] 'compare' (duration: 201.96387ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:31.919108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.813822Z","time spent":"2.105214853s","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:31.919215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.915686687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-22T01:51:31.919225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370266933s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.193\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-22T01:51:31.919267Z","caller":"traceutil/trace.go:171","msg":"trace[1808164238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:379; }","duration":"1.915769432s","start":"2026-09-22T01:51:30.00348Z","end":"2026-09-22T01:51:31.919249Z","steps":["trace[1808164238] 'agreement among raft nodes before linearized reading' (duration: 1.915677226s)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:31.919286Z","caller":"traceutil/trace.go:171","msg":"trace[1057120016] range","detail":"{range_begin:/registry/masterleases/162.253.55.193; range_end:; response_count:1; response_revision:379; }","duration":"1.370364439s","start":"2026-09-22T01:51:30.548907Z","end":"2026-09-22T01:51:31.919271Z","steps":["trace[1057120016] 'agreement among raft nodes before linearized reading' (duration: 1.370231271s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:31.919321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:30.548893Z","time spent":"1.370418912s","remote":"127.0.0.1:60542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.193\" "} {"level":"warn","ts":"2026-09-22T01:51:31.919312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:30.00346Z","time spent":"1.915840245s","remote":"127.0.0.1:60782","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":"warn","ts":"2026-09-22T01:51:31.919458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.032616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:31.919492Z","caller":"traceutil/trace.go:171","msg":"trace[2003832180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"109.10079ms","start":"2026-09-22T01:51:31.81038Z","end":"2026-09-22T01:51:31.919481Z","steps":["trace[2003832180] 'agreement among raft nodes before linearized reading' (duration: 109.038706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:31.919409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.982890471s","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-09-22T01:51:31.919625Z","caller":"traceutil/trace.go:171","msg":"trace[427596773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:379; }","duration":"1.98323161s","start":"2026-09-22T01:51:29.936385Z","end":"2026-09-22T01:51:31.919617Z","steps":["trace[427596773] 'agreement among raft nodes before linearized reading' (duration: 1.982756804s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:31.91961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.942930533s","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-09-22T01:51:31.919667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.936366Z","time spent":"1.983283883s","remote":"127.0.0.1:60782","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-09-22T01:51:31.91972Z","caller":"traceutil/trace.go:171","msg":"trace[1328135031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"1.943051861s","start":"2026-09-22T01:51:29.976645Z","end":"2026-09-22T01:51:31.919697Z","steps":["trace[1328135031] 'agreement among raft nodes before linearized reading' (duration: 1.942867989s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:31.921197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:29.976636Z","time spent":"1.944499872s","remote":"127.0.0.1:60782","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-09-22T01:51:32.129726Z","caller":"traceutil/trace.go:171","msg":"trace[994195745] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"205.141758ms","start":"2026-09-22T01:51:31.924559Z","end":"2026-09-22T01:51:32.129701Z","steps":["trace[994195745] 'process raft request' (duration: 112.238517ms)","trace[994195745] 'compare' (duration: 92.702759ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.130002Z","caller":"traceutil/trace.go:171","msg":"trace[1371102292] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"205.271266ms","start":"2026-09-22T01:51:31.924685Z","end":"2026-09-22T01:51:32.129956Z","steps":["trace[1371102292] 'process raft request' (duration: 204.968878ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.130149Z","caller":"traceutil/trace.go:171","msg":"trace[782761814] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:394; }","duration":"190.768224ms","start":"2026-09-22T01:51:31.939368Z","end":"2026-09-22T01:51:32.130136Z","steps":["trace[782761814] 'read index received' (duration: 97.439768ms)","trace[782761814] 'applied index is now lower than readState.Index' (duration: 93.327556ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.130214Z","caller":"traceutil/trace.go:171","msg":"trace[1611094424] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"204.803069ms","start":"2026-09-22T01:51:31.925392Z","end":"2026-09-22T01:51:32.130195Z","steps":["trace[1611094424] 'process raft request' (duration: 204.695963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:32.130252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.235867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:32.130289Z","caller":"traceutil/trace.go:171","msg":"trace[754737412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:383; }","duration":"201.306821ms","start":"2026-09-22T01:51:31.928964Z","end":"2026-09-22T01:51:32.130271Z","steps":["trace[754737412] 'agreement among raft nodes before linearized reading' (duration: 201.218816ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.130269Z","caller":"traceutil/trace.go:171","msg":"trace[978507482] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"205.036863ms","start":"2026-09-22T01:51:31.92521Z","end":"2026-09-22T01:51:32.130247Z","steps":["trace[978507482] 'process raft request' (duration: 204.62447ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.186536Z","caller":"traceutil/trace.go:171","msg":"trace[1101530575] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"239.11009ms","start":"2026-09-22T01:51:31.9474Z","end":"2026-09-22T01:51:32.18651Z","steps":["trace[1101530575] 'process raft request' (duration: 239.027126ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.186593Z","caller":"traceutil/trace.go:171","msg":"trace[6176741] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"246.34026ms","start":"2026-09-22T01:51:31.94023Z","end":"2026-09-22T01:51:32.18657Z","steps":["trace[6176741] 'process raft request' (duration: 246.060584ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.327453Z","caller":"traceutil/trace.go:171","msg":"trace[436983251] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"127.738135ms","start":"2026-09-22T01:51:32.199683Z","end":"2026-09-22T01:51:32.327421Z","steps":["trace[436983251] 'process raft request' (duration: 115.559522ms)","trace[436983251] 'compare' (duration: 12.056487ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:32.958897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.608396ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-09-22T01:51:32.95899Z","caller":"traceutil/trace.go:171","msg":"trace[615282789] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:403; }","duration":"321.274458ms","start":"2026-09-22T01:51:32.637697Z","end":"2026-09-22T01:51:32.958972Z","steps":["trace[615282789] 'read index received' (duration: 107.583828ms)","trace[615282789] 'applied index is now lower than readState.Index' (duration: 213.68925ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:32.959079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:32.575026Z","time spent":"384.047942ms","remote":"127.0.0.1:32804","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-09-22T01:51:32.959072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.364613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-09-22T01:51:32.959146Z","caller":"traceutil/trace.go:171","msg":"trace[1919067749] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:388; }","duration":"321.465268ms","start":"2026-09-22T01:51:32.637671Z","end":"2026-09-22T01:51:32.959136Z","steps":["trace[1919067749] 'agreement among raft nodes before linearized reading' (duration: 321.342881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:32.959208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:32.637653Z","time spent":"321.515091ms","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4349,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-09-22T01:51:33.215125Z","caller":"traceutil/trace.go:171","msg":"trace[1551635610] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"254.639697ms","start":"2026-09-22T01:51:32.960453Z","end":"2026-09-22T01:51:33.215093Z","steps":["trace[1551635610] 'process raft request' (duration: 254.477068ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:33.387192Z","caller":"traceutil/trace.go:171","msg":"trace[1733290006] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:404; }","duration":"374.050477ms","start":"2026-09-22T01:51:33.013121Z","end":"2026-09-22T01:51:33.387171Z","steps":["trace[1733290006] 'read index received' (duration: 201.879509ms)","trace[1733290006] 'applied index is now lower than readState.Index' (duration: 172.169798ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:33.387435Z","caller":"traceutil/trace.go:171","msg":"trace[622224062] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"420.396219ms","start":"2026-09-22T01:51:32.966969Z","end":"2026-09-22T01:51:33.387366Z","steps":["trace[622224062] 'process raft request' (duration: 415.428164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:33.387477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.339383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:51:33.387615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:32.966945Z","time spent":"420.551957ms","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:33.38789Z","caller":"traceutil/trace.go:171","msg":"trace[1421868955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"374.492552ms","start":"2026-09-22T01:51:33.013081Z","end":"2026-09-22T01:51:33.387574Z","steps":["trace[1421868955] 'agreement among raft nodes before linearized reading' (duration: 374.254228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:33.388078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:33.013066Z","time spent":"374.997101ms","remote":"127.0.0.1:60484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T01:51:33.669579Z","caller":"traceutil/trace.go:171","msg":"trace[232688692] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"195.780709ms","start":"2026-09-22T01:51:33.473459Z","end":"2026-09-22T01:51:33.66924Z","steps":["trace[232688692] 'process raft request' (duration: 195.521174ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:34.097023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.166999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:34.097115Z","caller":"traceutil/trace.go:171","msg":"trace[564426407] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:407; }","duration":"482.871284ms","start":"2026-09-22T01:51:33.614228Z","end":"2026-09-22T01:51:34.0971Z","steps":["trace[564426407] 'read index received' (duration: 54.750364ms)","trace[564426407] 'applied index is now lower than readState.Index' (duration: 428.11991ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:34.097198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.97504ms","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-09-22T01:51:34.097274Z","caller":"traceutil/trace.go:171","msg":"trace[1169130197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:393; }","duration":"483.076636ms","start":"2026-09-22T01:51:33.614186Z","end":"2026-09-22T01:51:34.097262Z","steps":["trace[1169130197] 'agreement among raft nodes before linearized reading' (duration: 482.953809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:34.097341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:33.614171Z","time spent":"483.124848ms","remote":"127.0.0.1:60782","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":"info","ts":"2026-09-22T01:51:34.097713Z","caller":"traceutil/trace.go:171","msg":"trace[802346283] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"619.457395ms","start":"2026-09-22T01:51:33.477994Z","end":"2026-09-22T01:51:34.097452Z","steps":["trace[802346283] 'process raft request' (duration: 375.786276ms)","trace[802346283] 'compare' (duration: 243.047852ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:34.098043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:33.477976Z","time spent":"619.833036ms","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:34.298037Z","caller":"traceutil/trace.go:171","msg":"trace[599369937] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"109.322242ms","start":"2026-09-22T01:51:34.188687Z","end":"2026-09-22T01:51:34.29801Z","steps":["trace[599369937] 'process raft request' (duration: 109.268919ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:34.29813Z","caller":"traceutil/trace.go:171","msg":"trace[951221326] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"109.417217ms","start":"2026-09-22T01:51:34.188674Z","end":"2026-09-22T01:51:34.298092Z","steps":["trace[951221326] 'process raft request' (duration: 109.164523ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:00.631146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.806349ms","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-09-22T01:52:00.631267Z","caller":"traceutil/trace.go:171","msg":"trace[291210697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:484; }","duration":"149.981619ms","start":"2026-09-22T01:52:00.481265Z","end":"2026-09-22T01:52:00.631247Z","steps":["trace[291210697] 'range keys from in-memory index tree' (duration: 149.711393ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:00.631327Z","caller":"traceutil/trace.go:171","msg":"trace[180506877] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"114.680226ms","start":"2026-09-22T01:52:00.516575Z","end":"2026-09-22T01:52:00.631256Z","steps":["trace[180506877] 'process raft request' (duration: 24.353936ms)","trace[180506877] 'compare' (duration: 90.147608ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:14.921618Z","caller":"traceutil/trace.go:171","msg":"trace[103421814] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"109.319022ms","start":"2026-09-22T01:52:14.812272Z","end":"2026-09-22T01:52:14.921591Z","steps":["trace[103421814] 'process raft request' (duration: 39.807271ms)","trace[103421814] 'compare' (duration: 69.142157ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:16.464091Z","caller":"traceutil/trace.go:171","msg":"trace[1901411986] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"762.579282ms","start":"2026-09-22T01:52:15.701491Z","end":"2026-09-22T01:52:16.46407Z","steps":["trace[1901411986] 'process raft request' (duration: 756.759123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:16.464297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:15.701471Z","time spent":"762.738422ms","remote":"127.0.0.1:60554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:52:16.468653Z","caller":"traceutil/trace.go:171","msg":"trace[996878021] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"761.933199ms","start":"2026-09-22T01:52:15.706691Z","end":"2026-09-22T01:52:16.468625Z","steps":["trace[996878021] 'process raft request' (duration: 761.624058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:16.468835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:15.706673Z","time spent":"762.045096ms","remote":"127.0.0.1:60554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:52:16.469128Z","caller":"traceutil/trace.go:171","msg":"trace[1497007849] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"756.067959ms","start":"2026-09-22T01:52:15.713027Z","end":"2026-09-22T01:52:16.469095Z","steps":["trace[1497007849] 'process raft request' (duration: 755.836394ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:16.469224Z","caller":"traceutil/trace.go:171","msg":"trace[1609527847] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"703.330392ms","start":"2026-09-22T01:52:15.765869Z","end":"2026-09-22T01:52:16.469199Z","steps":["trace[1609527847] 'process raft request' (duration: 703.083895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:16.469339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:15.765842Z","time spent":"703.441859ms","remote":"127.0.0.1:60554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T01:52:16.469467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:15.713009Z","time spent":"756.224429ms","remote":"127.0.0.1:60554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:52:16.486774Z","caller":"traceutil/trace.go:171","msg":"trace[2004731848] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:615; }","duration":"473.010698ms","start":"2026-09-22T01:52:16.013736Z","end":"2026-09-22T01:52:16.486747Z","steps":["trace[2004731848] 'read index received' (duration: 444.530949ms)","trace[2004731848] 'applied index is now lower than readState.Index' (duration: 28.478309ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:16.48689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.132756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:16.487028Z","caller":"traceutil/trace.go:171","msg":"trace[221795385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"473.313428ms","start":"2026-09-22T01:52:16.013693Z","end":"2026-09-22T01:52:16.487007Z","steps":["trace[221795385] 'agreement among raft nodes before linearized reading' (duration: 473.131906ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:16.487207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:16.013674Z","time spent":"473.472958ms","remote":"127.0.0.1:60484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T01:52:17.781944Z","caller":"traceutil/trace.go:171","msg":"trace[313485805] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"137.631074ms","start":"2026-09-22T01:52:17.644291Z","end":"2026-09-22T01:52:17.781922Z","steps":["trace[313485805] 'read index received' (duration: 137.317153ms)","trace[313485805] 'applied index is now lower than readState.Index' (duration: 312.851µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:17.782152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.845039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-09-22T01:52:17.78219Z","caller":"traceutil/trace.go:171","msg":"trace[1847520351] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:631; }","duration":"137.910393ms","start":"2026-09-22T01:52:17.644268Z","end":"2026-09-22T01:52:17.782178Z","steps":["trace[1847520351] 'agreement among raft nodes before linearized reading' (duration: 137.742592ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:17.782886Z","caller":"traceutil/trace.go:171","msg":"trace[1447743308] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"145.37092ms","start":"2026-09-22T01:52:17.637504Z","end":"2026-09-22T01:52:17.782875Z","steps":["trace[1447743308] 'process raft request' (duration: 144.057993ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:17.959364Z","caller":"traceutil/trace.go:171","msg":"trace[28895617] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"165.483935ms","start":"2026-09-22T01:52:17.793855Z","end":"2026-09-22T01:52:17.959338Z","steps":["trace[28895617] 'read index received' (duration: 154.875047ms)","trace[28895617] 'applied index is now lower than readState.Index' (duration: 10.607718ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:17.959581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.711391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-09-22T01:52:17.959628Z","caller":"traceutil/trace.go:171","msg":"trace[1729071810] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:632; }","duration":"165.805797ms","start":"2026-09-22T01:52:17.793809Z","end":"2026-09-22T01:52:17.959615Z","steps":["trace[1729071810] 'agreement among raft nodes before linearized reading' (duration: 165.625524ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:17.959641Z","caller":"traceutil/trace.go:171","msg":"trace[230315731] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"272.571149ms","start":"2026-09-22T01:52:17.686912Z","end":"2026-09-22T01:52:17.959483Z","steps":["trace[230315731] 'process raft request' (duration: 261.80375ms)","trace[230315731] 'compare' (duration: 10.424606ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:17.968781Z","caller":"traceutil/trace.go:171","msg":"trace[1997553516] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"121.09389ms","start":"2026-09-22T01:52:17.843368Z","end":"2026-09-22T01:52:17.964461Z","steps":["trace[1997553516] 'process raft request' (duration: 120.969981ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:18.351481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.43753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:52:18.351548Z","caller":"traceutil/trace.go:171","msg":"trace[710317719] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"289.376615ms","start":"2026-09-22T01:52:18.062162Z","end":"2026-09-22T01:52:18.351539Z","steps":["trace[710317719] 'read index received' (duration: 147.786034ms)","trace[710317719] 'applied index is now lower than readState.Index' (duration: 141.589821ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:18.35164Z","caller":"traceutil/trace.go:171","msg":"trace[1769214173] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"290.33223ms","start":"2026-09-22T01:52:18.06126Z","end":"2026-09-22T01:52:18.351592Z","steps":["trace[1769214173] 'process raft request' (duration: 148.722017ms)","trace[1769214173] 'compare' (duration: 141.277379ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:18.351689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.524675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"warn","ts":"2026-09-22T01:52:18.351776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.664484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:18.351824Z","caller":"traceutil/trace.go:171","msg":"trace[874711619] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:634; }","duration":"289.640392ms","start":"2026-09-22T01:52:18.062158Z","end":"2026-09-22T01:52:18.351798Z","steps":["trace[874711619] 'agreement among raft nodes before linearized reading' (duration: 289.430308ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:18.351862Z","caller":"traceutil/trace.go:171","msg":"trace[299038750] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:634; }","duration":"240.825684ms","start":"2026-09-22T01:52:18.11102Z","end":"2026-09-22T01:52:18.351845Z","steps":["trace[299038750] 'agreement among raft nodes before linearized reading' (duration: 240.660313ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:21.913836Z","caller":"traceutil/trace.go:171","msg":"trace[1055055324] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"234.60317ms","start":"2026-09-22T01:52:21.679181Z","end":"2026-09-22T01:52:21.913784Z","steps":["trace[1055055324] 'read index received' (duration: 228.770526ms)","trace[1055055324] 'applied index is now lower than readState.Index' (duration: 5.831794ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:21.913877Z","caller":"traceutil/trace.go:171","msg":"trace[131950085] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"318.795033ms","start":"2026-09-22T01:52:21.595044Z","end":"2026-09-22T01:52:21.913839Z","steps":["trace[131950085] 'process raft request' (duration: 313.56945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:21.91401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.786702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-22T01:52:21.914064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:21.595019Z","time spent":"318.955454ms","remote":"127.0.0.1:60600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:52:21.914094Z","caller":"traceutil/trace.go:171","msg":"trace[1846999675] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:653; }","duration":"234.935452ms","start":"2026-09-22T01:52:21.679139Z","end":"2026-09-22T01:52:21.914074Z","steps":["trace[1846999675] 'agreement among raft nodes before linearized reading' (duration: 234.769301ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:22.98261Z","caller":"traceutil/trace.go:171","msg":"trace[112692572] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"102.574496ms","start":"2026-09-22T01:52:22.880019Z","end":"2026-09-22T01:52:22.982593Z","steps":["trace[112692572] 'read index received' (duration: 102.552315ms)","trace[112692572] 'applied index is now lower than readState.Index' (duration: 21.481µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:22.982651Z","caller":"traceutil/trace.go:171","msg":"trace[89433347] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"230.180343ms","start":"2026-09-22T01:52:22.752443Z","end":"2026-09-22T01:52:22.982623Z","steps":["trace[89433347] 'process raft request' (duration: 230.009602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:22.982779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.741607ms","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-09-22T01:52:22.982809Z","caller":"traceutil/trace.go:171","msg":"trace[1485259904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:661; }","duration":"102.808492ms","start":"2026-09-22T01:52:22.879991Z","end":"2026-09-22T01:52:22.982799Z","steps":["trace[1485259904] 'agreement among raft nodes before linearized reading' (duration: 102.692854ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.483196Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907518455698597,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-22T01:52:23.644118Z","caller":"traceutil/trace.go:171","msg":"trace[122778681] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"695.862858ms","start":"2026-09-22T01:52:22.94823Z","end":"2026-09-22T01:52:23.644093Z","steps":["trace[122778681] 'process raft request' (duration: 695.316481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.644275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:22.948199Z","time spent":"696.002677ms","remote":"127.0.0.1:60600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:52:23.658373Z","caller":"traceutil/trace.go:171","msg":"trace[520853600] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:694; }","duration":"675.684118ms","start":"2026-09-22T01:52:22.982663Z","end":"2026-09-22T01:52:23.658347Z","steps":["trace[520853600] 'read index received' (duration: 660.689773ms)","trace[520853600] 'applied index is now lower than readState.Index' (duration: 14.993185ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:23.658638Z","caller":"traceutil/trace.go:171","msg":"trace[2021452302] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"672.370563ms","start":"2026-09-22T01:52:22.986256Z","end":"2026-09-22T01:52:23.658626Z","steps":["trace[2021452302] 'process raft request' (duration: 671.981086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.658742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:22.986233Z","time spent":"672.436547ms","remote":"127.0.0.1:60782","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-09-22T01:52:23.659019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.851217ms","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-09-22T01:52:23.659093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.403734ms","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-09-22T01:52:23.659134Z","caller":"traceutil/trace.go:171","msg":"trace[1704247526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:663; }","duration":"693.479309ms","start":"2026-09-22T01:52:22.965644Z","end":"2026-09-22T01:52:23.659123Z","steps":["trace[1704247526] 'agreement among raft nodes before linearized reading' (duration: 693.380982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.659161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:22.965624Z","time spent":"693.529722ms","remote":"127.0.0.1:60782","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":"warn","ts":"2026-09-22T01:52:23.659197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.195908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:23.659268Z","caller":"traceutil/trace.go:171","msg":"trace[873394348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"645.343117ms","start":"2026-09-22T01:52:23.013909Z","end":"2026-09-22T01:52:23.659252Z","steps":["trace[873394348] 'agreement among raft nodes before linearized reading' (duration: 645.213659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.659313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:23.013888Z","time spent":"645.416622ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T01:52:23.659224Z","caller":"traceutil/trace.go:171","msg":"trace[2098468984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:663; }","duration":"656.052941ms","start":"2026-09-22T01:52:23.003062Z","end":"2026-09-22T01:52:23.659114Z","steps":["trace[2098468984] 'agreement among raft nodes before linearized reading' (duration: 655.757241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:23.659517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:23.00305Z","time spent":"656.424226ms","remote":"127.0.0.1:60782","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-09-22T01:52:25.06909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907518455698605,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-22T01:52:25.142808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128708956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:25.142881Z","caller":"traceutil/trace.go:171","msg":"trace[1161475431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"1.128841555s","start":"2026-09-22T01:52:24.014023Z","end":"2026-09-22T01:52:25.142864Z","steps":["trace[1161475431] 'range keys from in-memory index tree' (duration: 1.128635761s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:25.142915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:24.014003Z","time spent":"1.12890403s","remote":"127.0.0.1:60484","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-09-22T01:52:25.237785Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.078402109s","expected-duration":"1s"} {"level":"info","ts":"2026-09-22T01:52:25.241539Z","caller":"traceutil/trace.go:171","msg":"trace[786571200] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"1.083842197s","start":"2026-09-22T01:52:24.157669Z","end":"2026-09-22T01:52:25.241511Z","steps":["trace[786571200] 'process raft request' (duration: 1.081582504s)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:25.241492Z","caller":"traceutil/trace.go:171","msg":"trace[1867465312] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"673.460753ms","start":"2026-09-22T01:52:24.568Z","end":"2026-09-22T01:52:25.241461Z","steps":["trace[1867465312] 'read index received' (duration: 670.101335ms)","trace[1867465312] 'applied index is now lower than readState.Index' (duration: 3.357948ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:25.242371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.332712ms","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-09-22T01:52:25.242458Z","caller":"traceutil/trace.go:171","msg":"trace[256363022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:667; }","duration":"674.456911ms","start":"2026-09-22T01:52:24.567943Z","end":"2026-09-22T01:52:25.2424Z","steps":["trace[256363022] 'agreement among raft nodes before linearized reading' (duration: 673.739182ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:25.242464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:24.15764Z","time spent":"1.084679204s","remote":"127.0.0.1:60600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:52:25.242501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:24.567924Z","time spent":"674.564058ms","remote":"127.0.0.1:60782","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-09-22T01:52:25.30364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.56837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:52:25.303675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.393357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:25.303718Z","caller":"traceutil/trace.go:171","msg":"trace[131585701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"159.659217ms","start":"2026-09-22T01:52:25.144036Z","end":"2026-09-22T01:52:25.303696Z","steps":["trace[131585701] 'agreement among raft nodes before linearized reading' (duration: 99.568364ms)","trace[131585701] 'range keys from in-memory index tree' (duration: 59.980015ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:25.303745Z","caller":"traceutil/trace.go:171","msg":"trace[887675637] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:667; }","duration":"432.490624ms","start":"2026-09-22T01:52:24.871236Z","end":"2026-09-22T01:52:25.303726Z","steps":["trace[887675637] 'agreement among raft nodes before linearized reading' (duration: 372.305175ms)","trace[887675637] 'count revisions from in-memory index tree' (duration: 60.06087ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:25.303787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:24.871162Z","time spent":"432.615412ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-09-22T01:52:25.303736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.522594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:52:25.304006Z","caller":"traceutil/trace.go:171","msg":"trace[2073010955] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:667; }","duration":"351.866307ms","start":"2026-09-22T01:52:24.952126Z","end":"2026-09-22T01:52:25.303993Z","steps":["trace[2073010955] 'agreement among raft nodes before linearized reading' (duration: 291.489635ms)","trace[2073010955] 'count revisions from in-memory index tree' (duration: 60.057731ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:25.304044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:24.952107Z","time spent":"351.92584ms","remote":"127.0.0.1:60766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-09-22T01:52:27.219249Z","caller":"traceutil/trace.go:171","msg":"trace[737571903] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"206.285079ms","start":"2026-09-22T01:52:27.012872Z","end":"2026-09-22T01:52:27.219157Z","steps":["trace[737571903] 'read index received' (duration: 206.054672ms)","trace[737571903] 'applied index is now lower than readState.Index' (duration: 229.387µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:27.219317Z","caller":"traceutil/trace.go:171","msg":"trace[1657943413] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"261.731573ms","start":"2026-09-22T01:52:26.957535Z","end":"2026-09-22T01:52:27.219267Z","steps":["trace[1657943413] 'process raft request' (duration: 261.423441ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:27.219458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.564547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:27.219502Z","caller":"traceutil/trace.go:171","msg":"trace[75852698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:700; }","duration":"206.659363ms","start":"2026-09-22T01:52:27.012831Z","end":"2026-09-22T01:52:27.21949Z","steps":["trace[75852698] 'agreement among raft nodes before linearized reading' (duration: 206.562587ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:27.224995Z","caller":"traceutil/trace.go:171","msg":"trace[269892470] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"208.415184ms","start":"2026-09-22T01:52:27.01655Z","end":"2026-09-22T01:52:27.224965Z","steps":["trace[269892470] 'process raft request' (duration: 208.126014ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.016912Z","caller":"traceutil/trace.go:171","msg":"trace[90513456] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"146.14102ms","start":"2026-09-22T01:52:31.870726Z","end":"2026-09-22T01:52:32.016867Z","steps":["trace[90513456] 'process raft request' (duration: 145.962178ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.194302Z","caller":"traceutil/trace.go:171","msg":"trace[235487368] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:806; }","duration":"177.276999ms","start":"2026-09-22T01:52:32.017004Z","end":"2026-09-22T01:52:32.194281Z","steps":["trace[235487368] 'read index received' (duration: 177.213575ms)","trace[235487368] 'applied index is now lower than readState.Index' (duration: 62.334µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:32.194462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.406224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.194478Z","caller":"traceutil/trace.go:171","msg":"trace[19242015] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"237.623596ms","start":"2026-09-22T01:52:31.956834Z","end":"2026-09-22T01:52:32.194457Z","steps":["trace[19242015] 'process raft request' (duration: 237.403561ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.194519Z","caller":"traceutil/trace.go:171","msg":"trace[893540861] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:773; }","duration":"220.5079ms","start":"2026-09-22T01:52:31.973995Z","end":"2026-09-22T01:52:32.194503Z","steps":["trace[893540861] 'agreement among raft nodes before linearized reading' (duration: 220.399603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.194569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.100621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:52:32.194631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.43853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.194661Z","caller":"traceutil/trace.go:171","msg":"trace[1440175651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"182.200188ms","start":"2026-09-22T01:52:32.012426Z","end":"2026-09-22T01:52:32.194626Z","steps":["trace[1440175651] 'agreement among raft nodes before linearized reading' (duration: 182.066028ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.194686Z","caller":"traceutil/trace.go:171","msg":"trace[70238677] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:773; }","duration":"239.534727ms","start":"2026-09-22T01:52:31.955137Z","end":"2026-09-22T01:52:32.194671Z","steps":["trace[70238677] 'agreement among raft nodes before linearized reading' (duration: 239.43948ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.194725Z","caller":"traceutil/trace.go:171","msg":"trace[1953680996] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"238.889733ms","start":"2026-09-22T01:52:31.955798Z","end":"2026-09-22T01:52:32.194687Z","steps":["trace[1953680996] 'process raft request' (duration: 238.322364ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.194775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.779359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:52:32.19482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.356754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.194866Z","caller":"traceutil/trace.go:171","msg":"trace[917928456] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:773; }","duration":"240.437899ms","start":"2026-09-22T01:52:31.954416Z","end":"2026-09-22T01:52:32.194854Z","steps":["trace[917928456] 'agreement among raft nodes before linearized reading' (duration: 240.362784ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.194871Z","caller":"traceutil/trace.go:171","msg":"trace[1302212707] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:773; }","duration":"220.912068ms","start":"2026-09-22T01:52:31.973928Z","end":"2026-09-22T01:52:32.19484Z","steps":["trace[1302212707] 'agreement among raft nodes before linearized reading' (duration: 220.738146ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.19445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.655482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.195392Z","caller":"traceutil/trace.go:171","msg":"trace[1297236887] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:773; }","duration":"220.627809ms","start":"2026-09-22T01:52:31.974735Z","end":"2026-09-22T01:52:32.195363Z","steps":["trace[1297236887] 'agreement among raft nodes before linearized reading' (duration: 219.63023ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.201635Z","caller":"traceutil/trace.go:171","msg":"trace[1217127282] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"156.876515ms","start":"2026-09-22T01:52:32.044741Z","end":"2026-09-22T01:52:32.201618Z","steps":["trace[1217127282] 'process raft request' (duration: 156.538572ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.201979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.996439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.202037Z","caller":"traceutil/trace.go:171","msg":"trace[1987344608] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:774; }","duration":"127.096275ms","start":"2026-09-22T01:52:32.074925Z","end":"2026-09-22T01:52:32.202021Z","steps":["trace[1987344608] 'agreement among raft nodes before linearized reading' (duration: 126.954016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.202088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.494784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.202387Z","caller":"traceutil/trace.go:171","msg":"trace[193208344] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:774; }","duration":"126.759173ms","start":"2026-09-22T01:52:32.075502Z","end":"2026-09-22T01:52:32.202261Z","steps":["trace[193208344] 'agreement among raft nodes before linearized reading' (duration: 126.479214ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.202229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.248756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:32.20299Z","caller":"traceutil/trace.go:171","msg":"trace[422842780] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:774; }","duration":"127.872779ms","start":"2026-09-22T01:52:32.074937Z","end":"2026-09-22T01:52:32.202809Z","steps":["trace[422842780] 'agreement among raft nodes before linearized reading' (duration: 127.267867ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.332398Z","caller":"traceutil/trace.go:171","msg":"trace[385940861] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"127.499994ms","start":"2026-09-22T01:52:32.204869Z","end":"2026-09-22T01:52:32.332369Z","steps":["trace[385940861] 'process raft request' (duration: 111.762221ms)","trace[385940861] 'compare' (duration: 15.611485ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:32.414294Z","caller":"traceutil/trace.go:171","msg":"trace[318704683] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:809; }","duration":"100.158103ms","start":"2026-09-22T01:52:32.314116Z","end":"2026-09-22T01:52:32.414274Z","steps":["trace[318704683] 'read index received' (duration: 2.517533ms)","trace[318704683] 'applied index is now lower than readState.Index' (duration: 97.63961ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:32.414365Z","caller":"traceutil/trace.go:171","msg":"trace[1296126752] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"204.080104ms","start":"2026-09-22T01:52:32.210258Z","end":"2026-09-22T01:52:32.414338Z","steps":["trace[1296126752] 'process raft request' (duration: 203.899242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.414422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.288762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-09-22T01:52:32.414453Z","caller":"traceutil/trace.go:171","msg":"trace[1098137465] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:776; }","duration":"100.365757ms","start":"2026-09-22T01:52:32.314078Z","end":"2026-09-22T01:52:32.414443Z","steps":["trace[1098137465] 'agreement among raft nodes before linearized reading' (duration: 100.291342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:32.415953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.699699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"info","ts":"2026-09-22T01:52:32.416028Z","caller":"traceutil/trace.go:171","msg":"trace[1220214578] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:777; }","duration":"101.795415ms","start":"2026-09-22T01:52:32.314216Z","end":"2026-09-22T01:52:32.416011Z","steps":["trace[1220214578] 'agreement among raft nodes before linearized reading' (duration: 101.615993ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:32.532297Z","caller":"traceutil/trace.go:171","msg":"trace[1833878449] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"105.558104ms","start":"2026-09-22T01:52:32.426717Z","end":"2026-09-22T01:52:32.532275Z","steps":["trace[1833878449] 'process raft request' (duration: 105.378231ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:34.974518Z","caller":"traceutil/trace.go:171","msg":"trace[503940636] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"153.775737ms","start":"2026-09-22T01:52:34.820724Z","end":"2026-09-22T01:52:34.9745Z","steps":["trace[503940636] 'process raft request' (duration: 153.653458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.250743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.444027ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:42.250888Z","caller":"traceutil/trace.go:171","msg":"trace[2140922864] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:831; }","duration":"159.609829ms","start":"2026-09-22T01:52:42.091256Z","end":"2026-09-22T01:52:42.250866Z","steps":["trace[2140922864] 'range keys from in-memory index tree' (duration: 159.424656ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.250882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.756307ms","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-09-22T01:52:42.250949Z","caller":"traceutil/trace.go:171","msg":"trace[1447487536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:831; }","duration":"796.877256ms","start":"2026-09-22T01:52:41.454053Z","end":"2026-09-22T01:52:42.250931Z","steps":["trace[1447487536] 'range keys from in-memory index tree' (duration: 796.610787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.250984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.454025Z","time spent":"796.95043ms","remote":"127.0.0.1:60782","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-09-22T01:52:42.251444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.607105ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:52:42.251519Z","caller":"traceutil/trace.go:171","msg":"trace[820322315] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"471.724496ms","start":"2026-09-22T01:52:41.779781Z","end":"2026-09-22T01:52:42.251506Z","steps":["trace[820322315] 'read index received' (duration: 42.363µs)","trace[820322315] 'applied index is now lower than readState.Index' (duration: 471.680913ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:42.251736Z","caller":"traceutil/trace.go:171","msg":"trace[567655017] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"742.555865ms","start":"2026-09-22T01:52:41.509165Z","end":"2026-09-22T01:52:42.251721Z","steps":["trace[567655017] 'process raft request' (duration: 252.565863ms)","trace[567655017] 'compare' (duration: 489.341966ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:52:42.251804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.509148Z","time spent":"742.616539ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:52:42.252073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.298277ms","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-09-22T01:52:42.252104Z","caller":"traceutil/trace.go:171","msg":"trace[1303850326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:832; }","duration":"472.362942ms","start":"2026-09-22T01:52:41.779731Z","end":"2026-09-22T01:52:42.252094Z","steps":["trace[1303850326] 'agreement among raft nodes before linearized reading' (duration: 472.239353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.252584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.779711Z","time spent":"472.855005ms","remote":"127.0.0.1:60782","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":"warn","ts":"2026-09-22T01:52:42.313183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.195793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:52:42.313266Z","caller":"traceutil/trace.go:171","msg":"trace[1944913405] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:833; }","duration":"113.306821ms","start":"2026-09-22T01:52:42.199929Z","end":"2026-09-22T01:52:42.313236Z","steps":["trace[1944913405] 'agreement among raft nodes before linearized reading' (duration: 113.192362ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:42.313232Z","caller":"traceutil/trace.go:171","msg":"trace[1272871942] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"457.740667ms","start":"2026-09-22T01:52:41.855464Z","end":"2026-09-22T01:52:42.313204Z","steps":["trace[1272871942] 'process raft request' (duration: 457.414943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.313351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.776158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:52:42.313454Z","caller":"traceutil/trace.go:171","msg":"trace[1607669389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:833; }","duration":"299.92978ms","start":"2026-09-22T01:52:42.013505Z","end":"2026-09-22T01:52:42.313435Z","steps":["trace[1607669389] 'agreement among raft nodes before linearized reading' (duration: 299.754488ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.313484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.855448Z","time spent":"457.902148ms","remote":"127.0.0.1:60754","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-09-22T01:52:42.313497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:42.01347Z","time spent":"300.017926ms","remote":"127.0.0.1:60484","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-09-22T01:52:42.31353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.648535ms","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-09-22T01:52:42.313583Z","caller":"traceutil/trace.go:171","msg":"trace[1021704000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:833; }","duration":"484.748112ms","start":"2026-09-22T01:52:41.82882Z","end":"2026-09-22T01:52:42.313568Z","steps":["trace[1021704000] 'agreement among raft nodes before linearized reading' (duration: 484.57794ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.313619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.828798Z","time spent":"484.812126ms","remote":"127.0.0.1:60782","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":"warn","ts":"2026-09-22T01:52:42.313739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.525465ms","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-09-22T01:52:42.313838Z","caller":"traceutil/trace.go:171","msg":"trace[1728408072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:833; }","duration":"490.656064ms","start":"2026-09-22T01:52:41.823171Z","end":"2026-09-22T01:52:42.313827Z","steps":["trace[1728408072] 'agreement among raft nodes before linearized reading' (duration: 489.902111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:42.313871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:52:41.823154Z","time spent":"490.704497ms","remote":"127.0.0.1:60782","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-09-22T01:52:42.402692Z","caller":"traceutil/trace.go:171","msg":"trace[2116237920] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"146.885168ms","start":"2026-09-22T01:52:42.255776Z","end":"2026-09-22T01:52:42.402661Z","steps":["trace[2116237920] 'process raft request' (duration: 141.296008ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:42.402701Z","caller":"traceutil/trace.go:171","msg":"trace[388415096] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"146.205031ms","start":"2026-09-22T01:52:42.256465Z","end":"2026-09-22T01:52:42.40267Z","steps":["trace[388415096] 'process raft request' (duration: 146.079972ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:56.267247Z","caller":"traceutil/trace.go:171","msg":"trace[1709550813] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"223.186648ms","start":"2026-09-22T01:52:56.044037Z","end":"2026-09-22T01:52:56.267224Z","steps":["trace[1709550813] 'process raft request' (duration: 223.057329ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:00.639276Z","caller":"traceutil/trace.go:171","msg":"trace[2071071643] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1064; }","duration":"134.440722ms","start":"2026-09-22T01:53:00.504813Z","end":"2026-09-22T01:53:00.639253Z","steps":["trace[2071071643] 'read index received' (duration: 75.81162ms)","trace[2071071643] 'applied index is now lower than readState.Index' (duration: 58.628162ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:53:00.639363Z","caller":"traceutil/trace.go:171","msg":"trace[1659094283] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"134.778258ms","start":"2026-09-22T01:53:00.504554Z","end":"2026-09-22T01:53:00.639333Z","steps":["trace[1659094283] 'process raft request' (duration: 111.471051ms)","trace[1659094283] 'compare' (duration: 23.114673ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:53:00.639522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.68836ms","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-09-22T01:53:00.639565Z","caller":"traceutil/trace.go:171","msg":"trace[84077707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1025; }","duration":"134.758506ms","start":"2026-09-22T01:53:00.504794Z","end":"2026-09-22T01:53:00.639553Z","steps":["trace[84077707] 'agreement among raft nodes before linearized reading' (duration: 134.604935ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:53:00.639808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.229861ms","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-09-22T01:53:00.63988Z","caller":"traceutil/trace.go:171","msg":"trace[244726211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1025; }","duration":"130.311467ms","start":"2026-09-22T01:53:00.50955Z","end":"2026-09-22T01:53:00.639861Z","steps":["trace[244726211] 'agreement among raft nodes before linearized reading' (duration: 130.055599ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:02.879547Z","caller":"traceutil/trace.go:171","msg":"trace[918017534] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"166.231781ms","start":"2026-09-22T01:53:02.713291Z","end":"2026-09-22T01:53:02.879523Z","steps":["trace[918017534] 'process raft request' (duration: 145.598313ms)","trace[918017534] 'compare' (duration: 20.436833ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:53:02.879831Z","caller":"traceutil/trace.go:171","msg":"trace[1096473403] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"125.949575ms","start":"2026-09-22T01:53:02.753853Z","end":"2026-09-22T01:53:02.879803Z","steps":["trace[1096473403] 'process raft request' (duration: 125.625972ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:27.43927Z","caller":"traceutil/trace.go:171","msg":"trace[426900694] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"191.863861ms","start":"2026-09-22T01:53:27.247362Z","end":"2026-09-22T01:53:27.439226Z","steps":["trace[426900694] 'process raft request' (duration: 191.688689ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:33.778781Z","caller":"traceutil/trace.go:171","msg":"trace[111082141] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"263.957372ms","start":"2026-09-22T01:53:33.514799Z","end":"2026-09-22T01:53:33.778756Z","steps":["trace[111082141] 'process raft request' (duration: 263.827933ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:35.962236Z","caller":"traceutil/trace.go:171","msg":"trace[2024252042] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"174.934069ms","start":"2026-09-22T01:53:35.787274Z","end":"2026-09-22T01:53:35.962208Z","steps":["trace[2024252042] 'process raft request' (duration: 174.751544ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:53:37.110651Z","caller":"traceutil/trace.go:171","msg":"trace[1783406530] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"136.132383ms","start":"2026-09-22T01:53:36.974493Z","end":"2026-09-22T01:53:37.110626Z","steps":["trace[1783406530] 'process raft request' (duration: 135.94736ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:54:31.873746Z","caller":"traceutil/trace.go:171","msg":"trace[768411626] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"256.565298ms","start":"2026-09-22T01:54:31.617136Z","end":"2026-09-22T01:54:31.873701Z","steps":["trace[768411626] 'process raft request' (duration: 256.39927ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:54:31.874475Z","caller":"traceutil/trace.go:171","msg":"trace[94606704] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"254.407104ms","start":"2026-09-22T01:54:31.620039Z","end":"2026-09-22T01:54:31.874446Z","steps":["trace[94606704] 'process raft request' (duration: 254.295386ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:54:41.316632Z","caller":"traceutil/trace.go:171","msg":"trace[580650337] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"113.468668ms","start":"2026-09-22T01:54:41.203138Z","end":"2026-09-22T01:54:41.316607Z","steps":["trace[580650337] 'process raft request' (duration: 113.313328ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:55:16.701058Z","caller":"traceutil/trace.go:171","msg":"trace[1855344641] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"130.930845ms","start":"2026-09-22T01:55:16.570096Z","end":"2026-09-22T01:55:16.701027Z","steps":["trace[1855344641] 'process raft request' (duration: 130.646763ms)"],"step_count":1}