{"level":"warn","ts":"2026-05-20T02:17:59.874372Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:17:59.874449Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-20T02:17:59.874528Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:17:59.874544Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-20T02:17:59.874868Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T02:17:59.875763Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-05-20T02:17:59.875912Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-20T02:17:59.881191Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.995785ms"} {"level":"info","ts":"2026-05-20T02:17:59.889422Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-05-20T02:17:59.889564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T02:17:59.889601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-05-20T02:17:59.889653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T02:17:59.88967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-05-20T02:17:59.889742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-05-20T02:17:59.898382Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T02:17:59.90159Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T02:17:59.903618Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T02:17:59.906775Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T02:17:59.906987Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:17:59.907108Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:17:59.907137Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:17:59.907443Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T02:17:59.910553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-05-20T02:17:59.914327Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-20T02:17:59.915409Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T02:17:59.915551Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-20T02:17:59.915584Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-20T02:17:59.915696Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T02:17:59.915748Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T02:18:00.690499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T02:18:00.690561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T02:18:00.6906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-05-20T02:18:00.690613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-05-20T02:18:00.69062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-20T02:18:00.690631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-05-20T02:18:00.690643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-20T02:18:00.691461Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T02:18:00.691575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:18:00.691691Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:18:00.691762Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:18:00.692147Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T02:18:00.692192Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T02:18:00.693119Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:18:00.693296Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:18:00.693372Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:18:00.693852Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T02:18:00.705655Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-05-20T02:18:06.504823Z","caller":"traceutil/trace.go:171","msg":"trace[594937287] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"127.04505ms","start":"2026-05-20T02:18:06.377753Z","end":"2026-05-20T02:18:06.504798Z","steps":["trace[594937287] 'process raft request' (duration: 126.461329ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:15.674145Z","caller":"traceutil/trace.go:171","msg":"trace[936716220] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"414.919336ms","start":"2026-05-20T02:18:15.259203Z","end":"2026-05-20T02:18:15.674122Z","steps":["trace[936716220] 'process raft request' (duration: 414.782893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:15.674741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:15.259193Z","time spent":"415.035528ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:16.63609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.04754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:18:16.636195Z","caller":"traceutil/trace.go:171","msg":"trace[186976950] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:449; }","duration":"1.104553058s","start":"2026-05-20T02:18:15.531628Z","end":"2026-05-20T02:18:16.636181Z","steps":["trace[186976950] 'read index received' (duration: 142.345613ms)","trace[186976950] 'applied index is now lower than readState.Index' (duration: 962.206274ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:18:16.636403Z","caller":"traceutil/trace.go:171","msg":"trace[1681612339] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"1.327718716s","start":"2026-05-20T02:18:15.308673Z","end":"2026-05-20T02:18:16.636391Z","steps":["trace[1681612339] 'process raft request' (duration: 408.167527ms)","trace[1681612339] 'compare' (duration: 918.257714ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:18:16.636472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:15.308648Z","time spent":"1.327792667s","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:16.63663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104999866s","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-05-20T02:18:16.636666Z","caller":"traceutil/trace.go:171","msg":"trace[1535593398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:438; }","duration":"1.105072067s","start":"2026-05-20T02:18:15.531585Z","end":"2026-05-20T02:18:16.636657Z","steps":["trace[1535593398] 'agreement among raft nodes before linearized reading' (duration: 1.105011926s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:16.636696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:15.531566Z","time spent":"1.105123188s","remote":"127.0.0.1:52774","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-05-20T02:18:16.636823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0602685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T02:18:16.636859Z","caller":"traceutil/trace.go:171","msg":"trace[1680922085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:438; }","duration":"1.060331663s","start":"2026-05-20T02:18:15.576519Z","end":"2026-05-20T02:18:16.636851Z","steps":["trace[1680922085] 'agreement among raft nodes before linearized reading' (duration: 1.060280131s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:16.636884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:15.576497Z","time spent":"1.060381073s","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:18:16.637136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.051906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:16.637176Z","caller":"traceutil/trace.go:171","msg":"trace[1628029071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:438; }","duration":"947.114657ms","start":"2026-05-20T02:18:15.690051Z","end":"2026-05-20T02:18:16.637165Z","steps":["trace[1628029071] 'agreement among raft nodes before linearized reading' (duration: 947.066936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:16.6372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:15.690036Z","time spent":"947.158717ms","remote":"127.0.0.1:52510","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-05-20T02:18:17.080605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.063533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:18:17.080831Z","caller":"traceutil/trace.go:171","msg":"trace[1209167057] linearizableReadLoop","detail":"{readStateIndex:454; appliedIndex:451; }","duration":"433.816658ms","start":"2026-05-20T02:18:16.646998Z","end":"2026-05-20T02:18:17.080814Z","steps":["trace[1209167057] 'read index received' (duration: 160.442888ms)","trace[1209167057] 'applied index is now lower than readState.Index' (duration: 273.37292ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:18:17.080918Z","caller":"traceutil/trace.go:171","msg":"trace[844606440] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"437.814475ms","start":"2026-05-20T02:18:16.643093Z","end":"2026-05-20T02:18:17.080908Z","steps":["trace[844606440] 'process raft request' (duration: 164.336183ms)","trace[844606440] 'compare' (duration: 272.88824ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:18:17.080977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:16.643074Z","time spent":"437.869726ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:18:17.081228Z","caller":"traceutil/trace.go:171","msg":"trace[583667360] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"437.696992ms","start":"2026-05-20T02:18:16.643522Z","end":"2026-05-20T02:18:17.081219Z","steps":["trace[583667360] 'process raft request' (duration: 437.185033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:17.081496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.099324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:17.081554Z","caller":"traceutil/trace.go:171","msg":"trace[1981045834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:441; }","duration":"433.175495ms","start":"2026-05-20T02:18:16.648362Z","end":"2026-05-20T02:18:17.081537Z","steps":["trace[1981045834] 'agreement among raft nodes before linearized reading' (duration: 433.083134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:17.081595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:16.648355Z","time spent":"433.232456ms","remote":"127.0.0.1:52520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T02:18:17.08161Z","caller":"traceutil/trace.go:171","msg":"trace[2044504003] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"437.749313ms","start":"2026-05-20T02:18:16.64383Z","end":"2026-05-20T02:18:17.081579Z","steps":["trace[2044504003] 'process raft request' (duration: 436.951838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:17.081289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:16.643503Z","time spent":"437.758104ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:17.081744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:16.643819Z","time spent":"437.850366ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:17.081829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.812176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"info","ts":"2026-05-20T02:18:17.081901Z","caller":"traceutil/trace.go:171","msg":"trace[36480976] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:441; }","duration":"434.934049ms","start":"2026-05-20T02:18:16.646951Z","end":"2026-05-20T02:18:17.081885Z","steps":["trace[36480976] 'agreement among raft nodes before linearized reading' (duration: 434.728495ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:17.081946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:16.646935Z","time spent":"435.0024ms","remote":"127.0.0.1:52702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7317,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-05-20T02:18:22.985827Z","caller":"traceutil/trace.go:171","msg":"trace[708978408] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:465; }","duration":"323.0854ms","start":"2026-05-20T02:18:22.662716Z","end":"2026-05-20T02:18:22.985802Z","steps":["trace[708978408] 'read index received' (duration: 322.834025ms)","trace[708978408] 'applied index is now lower than readState.Index' (duration: 250.305µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:18:22.985915Z","caller":"traceutil/trace.go:171","msg":"trace[2105265560] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"460.868635ms","start":"2026-05-20T02:18:22.525021Z","end":"2026-05-20T02:18:22.985889Z","steps":["trace[2105265560] 'process raft request' (duration: 460.619141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:22.985965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.237923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:18:22.985997Z","caller":"traceutil/trace.go:171","msg":"trace[1111692267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:452; }","duration":"323.342515ms","start":"2026-05-20T02:18:22.662645Z","end":"2026-05-20T02:18:22.985988Z","steps":["trace[1111692267] 'agreement among raft nodes before linearized reading' (duration: 323.260474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:22.986028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:22.662615Z","time spent":"323.405626ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T02:18:22.986028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:22.524993Z","time spent":"460.967207ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:18:27.184169Z","caller":"traceutil/trace.go:171","msg":"trace[694997081] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"257.23444ms","start":"2026-05-20T02:18:26.926908Z","end":"2026-05-20T02:18:27.184142Z","steps":["trace[694997081] 'process raft request' (duration: 257.089617ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:27.447365Z","caller":"traceutil/trace.go:171","msg":"trace[1174102203] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"506.5536ms","start":"2026-05-20T02:18:26.940782Z","end":"2026-05-20T02:18:27.447335Z","steps":["trace[1174102203] 'process raft request' (duration: 506.277034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.44752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.940751Z","time spent":"506.693832ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.447625Z","caller":"traceutil/trace.go:171","msg":"trace[1871812179] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"506.767714ms","start":"2026-05-20T02:18:26.940844Z","end":"2026-05-20T02:18:27.447612Z","steps":["trace[1871812179] 'process raft request' (duration: 506.329955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.447674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.940831Z","time spent":"506.821224ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.447985Z","caller":"traceutil/trace.go:171","msg":"trace[812008276] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"493.114682ms","start":"2026-05-20T02:18:26.954862Z","end":"2026-05-20T02:18:27.447976Z","steps":["trace[812008276] 'process raft request' (duration: 492.561892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.448028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.954854Z","time spent":"493.153453ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.448454Z","caller":"traceutil/trace.go:171","msg":"trace[1719278265] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"489.653705ms","start":"2026-05-20T02:18:26.958762Z","end":"2026-05-20T02:18:27.448415Z","steps":["trace[1719278265] 'process raft request' (duration: 489.113916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.448606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.95874Z","time spent":"489.798918ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.448909Z","caller":"traceutil/trace.go:171","msg":"trace[1121155177] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"489.89186ms","start":"2026-05-20T02:18:26.959007Z","end":"2026-05-20T02:18:27.448899Z","steps":["trace[1121155177] 'process raft request' (duration: 489.39802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.448966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.958999Z","time spent":"489.944811ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.449123Z","caller":"traceutil/trace.go:171","msg":"trace[484844978] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"487.303711ms","start":"2026-05-20T02:18:26.96181Z","end":"2026-05-20T02:18:27.449114Z","steps":["trace[484844978] 'process raft request' (duration: 486.73154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.449176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.961803Z","time spent":"487.349262ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.453063Z","caller":"traceutil/trace.go:171","msg":"trace[1329447131] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"493.894118ms","start":"2026-05-20T02:18:26.959035Z","end":"2026-05-20T02:18:27.452929Z","steps":["trace[1329447131] 'process raft request' (duration: 489.443312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.453225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.959003Z","time spent":"494.166272ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.453669Z","caller":"traceutil/trace.go:171","msg":"trace[1154112678] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"355.324127ms","start":"2026-05-20T02:18:27.098233Z","end":"2026-05-20T02:18:27.453557Z","steps":["trace[1154112678] 'process raft request' (duration: 350.951364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.453737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:27.098213Z","time spent":"355.48736ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.453912Z","caller":"traceutil/trace.go:171","msg":"trace[1783440632] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"462.787142ms","start":"2026-05-20T02:18:26.991115Z","end":"2026-05-20T02:18:27.453902Z","steps":["trace[1783440632] 'process raft request' (duration: 457.938609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.453969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.991085Z","time spent":"462.853983ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:18:27.454219Z","caller":"traceutil/trace.go:171","msg":"trace[1225146867] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"488.659127ms","start":"2026-05-20T02:18:26.965534Z","end":"2026-05-20T02:18:27.454193Z","steps":["trace[1225146867] 'process raft request' (duration: 483.327296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.454275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.965509Z","time spent":"488.731828ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:18:27.455105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.166285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:18:27.455141Z","caller":"traceutil/trace.go:171","msg":"trace[1793521607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"445.253987ms","start":"2026-05-20T02:18:27.009879Z","end":"2026-05-20T02:18:27.455133Z","steps":["trace[1793521607] 'agreement among raft nodes before linearized reading' (duration: 444.615905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.455174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:27.009864Z","time spent":"445.304998ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T02:18:27.456169Z","caller":"traceutil/trace.go:171","msg":"trace[1659202248] transaction","detail":"{read_only:false; number_of_response:1; response_revision:511; }","duration":"263.687074ms","start":"2026-05-20T02:18:27.192454Z","end":"2026-05-20T02:18:27.456142Z","steps":["trace[1659202248] 'process raft request' (duration: 263.339617ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:27.456245Z","caller":"traceutil/trace.go:171","msg":"trace[1207066970] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"265.216113ms","start":"2026-05-20T02:18:27.190999Z","end":"2026-05-20T02:18:27.456215Z","steps":["trace[1207066970] 'process raft request' (duration: 264.619941ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:27.456755Z","caller":"traceutil/trace.go:171","msg":"trace[2095714773] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"264.342517ms","start":"2026-05-20T02:18:27.192402Z","end":"2026-05-20T02:18:27.456745Z","steps":["trace[2095714773] 'process raft request' (duration: 263.319888ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:27.449303Z","caller":"traceutil/trace.go:171","msg":"trace[782557618] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:512; }","duration":"439.342603ms","start":"2026-05-20T02:18:27.009946Z","end":"2026-05-20T02:18:27.449289Z","steps":["trace[782557618] 'read index received' (duration: 174.073779ms)","trace[782557618] 'applied index is now lower than readState.Index' (duration: 265.267944ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:18:27.459717Z","caller":"traceutil/trace.go:171","msg":"trace[1520207232] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"467.711536ms","start":"2026-05-20T02:18:26.982935Z","end":"2026-05-20T02:18:27.450647Z","steps":["trace[1520207232] 'process raft request' (duration: 466.013504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.459761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:26.982917Z","time spent":"476.81803ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:18:27.460152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.479764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-20T02:18:27.460183Z","caller":"traceutil/trace.go:171","msg":"trace[775615671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:511; }","duration":"338.536126ms","start":"2026-05-20T02:18:27.121639Z","end":"2026-05-20T02:18:27.460175Z","steps":["trace[775615671] 'agreement among raft nodes before linearized reading' (duration: 338.440854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.460205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:27.121627Z","time spent":"338.568636ms","remote":"127.0.0.1:52774","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-05-20T02:18:27.460309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.043006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:27.460329Z","caller":"traceutil/trace.go:171","msg":"trace[665920393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"188.107878ms","start":"2026-05-20T02:18:27.272214Z","end":"2026-05-20T02:18:27.460322Z","steps":["trace[665920393] 'agreement among raft nodes before linearized reading' (duration: 188.071708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.460459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.120361ms","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-05-20T02:18:27.460481Z","caller":"traceutil/trace.go:171","msg":"trace[1137391351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"334.159522ms","start":"2026-05-20T02:18:27.126311Z","end":"2026-05-20T02:18:27.460471Z","steps":["trace[1137391351] 'agreement among raft nodes before linearized reading' (duration: 334.117981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.4605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:27.126281Z","time spent":"334.214383ms","remote":"127.0.0.1:52774","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-05-20T02:18:27.460599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.385172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:18:27.460622Z","caller":"traceutil/trace.go:171","msg":"trace[1365781833] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"338.438634ms","start":"2026-05-20T02:18:27.122171Z","end":"2026-05-20T02:18:27.460609Z","steps":["trace[1365781833] 'agreement among raft nodes before linearized reading' (duration: 338.402093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:27.460639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:27.12215Z","time spent":"338.484614ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-20T02:18:33.615316Z","caller":"traceutil/trace.go:171","msg":"trace[1794582496] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"112.174865ms","start":"2026-05-20T02:18:33.503115Z","end":"2026-05-20T02:18:33.61529Z","steps":["trace[1794582496] 'read index received' (duration: 111.186626ms)","trace[1794582496] 'applied index is now lower than readState.Index' (duration: 986.969µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:18:33.615525Z","caller":"traceutil/trace.go:171","msg":"trace[737571395] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"132.103376ms","start":"2026-05-20T02:18:33.483244Z","end":"2026-05-20T02:18:33.615347Z","steps":["trace[737571395] 'process raft request' (duration: 131.398443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:33.615831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.109458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T02:18:33.615891Z","caller":"traceutil/trace.go:171","msg":"trace[1344715310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"107.21536ms","start":"2026-05-20T02:18:33.508659Z","end":"2026-05-20T02:18:33.615874Z","steps":["trace[1344715310] 'agreement among raft nodes before linearized reading' (duration: 107.081828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:33.616045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.733632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:18:33.616147Z","caller":"traceutil/trace.go:171","msg":"trace[224408901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"104.905307ms","start":"2026-05-20T02:18:33.51122Z","end":"2026-05-20T02:18:33.616125Z","steps":["trace[224408901] 'agreement among raft nodes before linearized reading' (duration: 104.602001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:33.616094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.854681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-20T02:18:33.615681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.539052ms","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-05-20T02:18:33.616293Z","caller":"traceutil/trace.go:171","msg":"trace[6931369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"110.077646ms","start":"2026-05-20T02:18:33.506194Z","end":"2026-05-20T02:18:33.616272Z","steps":["trace[6931369] 'agreement among raft nodes before linearized reading' (duration: 109.637237ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:33.616311Z","caller":"traceutil/trace.go:171","msg":"trace[1309463229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"113.213046ms","start":"2026-05-20T02:18:33.503066Z","end":"2026-05-20T02:18:33.616279Z","steps":["trace[1309463229] 'agreement among raft nodes before linearized reading' (duration: 112.377879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:34.114355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.394649ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-20T02:18:34.114452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.618559Z","time spent":"495.887775ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-20T02:18:34.161083Z","caller":"traceutil/trace.go:171","msg":"trace[1585932255] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"539.464459ms","start":"2026-05-20T02:18:33.621569Z","end":"2026-05-20T02:18:34.161033Z","steps":["trace[1585932255] 'process raft request' (duration: 539.171203ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:34.161128Z","caller":"traceutil/trace.go:171","msg":"trace[1495218734] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"539.220753ms","start":"2026-05-20T02:18:33.621873Z","end":"2026-05-20T02:18:34.161094Z","steps":["trace[1495218734] 'process raft request' (duration: 539.03629ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:34.161261Z","caller":"traceutil/trace.go:171","msg":"trace[810277977] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"538.307097ms","start":"2026-05-20T02:18:33.62293Z","end":"2026-05-20T02:18:34.161237Z","steps":["trace[810277977] 'process raft request' (duration: 538.236866ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:34.161291Z","caller":"traceutil/trace.go:171","msg":"trace[863113727] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"538.336568ms","start":"2026-05-20T02:18:33.622932Z","end":"2026-05-20T02:18:34.161268Z","steps":["trace[863113727] 'process raft request' (duration: 538.115224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:34.161321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.621541Z","time spent":"539.644482ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:34.161411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.622905Z","time spent":"538.421739ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:34.161419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.622912Z","time spent":"538.429089ms","remote":"127.0.0.1:52774","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-05-20T02:18:34.161927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.621862Z","time spent":"539.345716ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:18:34.170303Z","caller":"traceutil/trace.go:171","msg":"trace[630070655] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"498.020276ms","start":"2026-05-20T02:18:33.672263Z","end":"2026-05-20T02:18:34.170283Z","steps":["trace[630070655] 'process raft request' (duration: 497.670729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:34.170475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:33.672245Z","time spent":"498.143539ms","remote":"127.0.0.1:53032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:18:35.559419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286360625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:35.559518Z","caller":"traceutil/trace.go:171","msg":"trace[978461373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"1.286522828s","start":"2026-05-20T02:18:34.272973Z","end":"2026-05-20T02:18:35.559496Z","steps":["trace[978461373] 'range keys from in-memory index tree' (duration: 1.286264303s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:35.559565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:34.272951Z","time spent":"1.286605679s","remote":"127.0.0.1:52510","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-05-20T02:18:35.755327Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.175845812s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T02:18:35.756427Z","caller":"traceutil/trace.go:171","msg":"trace[1320368352] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"195.399488ms","start":"2026-05-20T02:18:35.560975Z","end":"2026-05-20T02:18:35.756375Z","steps":["trace[1320368352] 'read index received' (duration: 194.540631ms)","trace[1320368352] 'applied index is now lower than readState.Index' (duration: 857.077µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:18:35.756613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.617332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:35.756666Z","caller":"traceutil/trace.go:171","msg":"trace[1092604784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"195.736814ms","start":"2026-05-20T02:18:35.560916Z","end":"2026-05-20T02:18:35.756653Z","steps":["trace[1092604784] 'agreement among raft nodes before linearized reading' (duration: 195.626732ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:35.756796Z","caller":"traceutil/trace.go:171","msg":"trace[1713475459] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.178346809s","start":"2026-05-20T02:18:34.578403Z","end":"2026-05-20T02:18:35.756749Z","steps":["trace[1713475459] 'process raft request' (duration: 1.177357141s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:35.75704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:34.578364Z","time spent":"1.178551542s","remote":"127.0.0.1:52614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:18:35.995175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.044001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:35.995273Z","caller":"traceutil/trace.go:171","msg":"trace[896029023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"229.189793ms","start":"2026-05-20T02:18:35.766061Z","end":"2026-05-20T02:18:35.995251Z","steps":["trace[896029023] 'range keys from in-memory index tree' (duration: 228.96381ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:35.995412Z","caller":"traceutil/trace.go:171","msg":"trace[1306244212] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"176.515326ms","start":"2026-05-20T02:18:35.818828Z","end":"2026-05-20T02:18:35.995343Z","steps":["trace[1306244212] 'process raft request' (duration: 176.097167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:37.776185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.009091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:37.776278Z","caller":"traceutil/trace.go:171","msg":"trace[683605284] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:651; }","duration":"320.157094ms","start":"2026-05-20T02:18:37.456095Z","end":"2026-05-20T02:18:37.776252Z","steps":["trace[683605284] 'range keys from in-memory index tree' (duration: 319.91783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:37.77632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:18:37.456072Z","time spent":"320.239216ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-05-20T02:18:37.788501Z","caller":"traceutil/trace.go:171","msg":"trace[909430611] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"130.381803ms","start":"2026-05-20T02:18:37.658093Z","end":"2026-05-20T02:18:37.788475Z","steps":["trace[909430611] 'process raft request' (duration: 130.249101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:40.648302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.161662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:40.648394Z","caller":"traceutil/trace.go:171","msg":"trace[1229074354] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:689; }","duration":"128.290584ms","start":"2026-05-20T02:18:40.520082Z","end":"2026-05-20T02:18:40.648372Z","steps":["trace[1229074354] 'range keys from in-memory index tree' (duration: 128.109081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:40.648744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.347554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T02:18:40.648806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.283382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:40.648849Z","caller":"traceutil/trace.go:171","msg":"trace[56135411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:689; }","duration":"129.547828ms","start":"2026-05-20T02:18:40.519283Z","end":"2026-05-20T02:18:40.648831Z","steps":["trace[56135411] 'range keys from in-memory index tree' (duration: 129.287993ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:40.648876Z","caller":"traceutil/trace.go:171","msg":"trace[1636907885] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:689; }","duration":"129.385574ms","start":"2026-05-20T02:18:40.519472Z","end":"2026-05-20T02:18:40.648858Z","steps":["trace[1636907885] 'count revisions from in-memory index tree' (duration: 129.242061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:18:40.649191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.889173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:18:40.64922Z","caller":"traceutil/trace.go:171","msg":"trace[1480979018] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:689; }","duration":"166.952915ms","start":"2026-05-20T02:18:40.482259Z","end":"2026-05-20T02:18:40.649212Z","steps":["trace[1480979018] 'count revisions from in-memory index tree' (duration: 166.21776ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:51.612754Z","caller":"traceutil/trace.go:171","msg":"trace[1000486698] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"265.775724ms","start":"2026-05-20T02:18:51.346949Z","end":"2026-05-20T02:18:51.612724Z","steps":["trace[1000486698] 'process raft request' (duration: 265.622231ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:18:51.622745Z","caller":"traceutil/trace.go:171","msg":"trace[1752029455] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"248.221838ms","start":"2026-05-20T02:18:51.374513Z","end":"2026-05-20T02:18:51.622734Z","steps":["trace[1752029455] 'process raft request' (duration: 248.153887ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:28.04278Z","caller":"traceutil/trace.go:171","msg":"trace[618421041] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"256.50847ms","start":"2026-05-20T02:19:27.786241Z","end":"2026-05-20T02:19:28.04275Z","steps":["trace[618421041] 'process raft request' (duration: 256.386658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:19:48.680314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.644481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T02:19:48.6804Z","caller":"traceutil/trace.go:171","msg":"trace[145485464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"118.777414ms","start":"2026-05-20T02:19:48.561605Z","end":"2026-05-20T02:19:48.680382Z","steps":["trace[145485464] 'range keys from in-memory index tree' (duration: 118.512297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:19:48.680436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.721009ms","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-05-20T02:19:48.680534Z","caller":"traceutil/trace.go:171","msg":"trace[805287013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"110.853021ms","start":"2026-05-20T02:19:48.569656Z","end":"2026-05-20T02:19:48.680509Z","steps":["trace[805287013] 'range keys from in-memory index tree' (duration: 110.544256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:19:48.680697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.048779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-20T02:19:48.680848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.5613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:19:48.680965Z","caller":"traceutil/trace.go:171","msg":"trace[30529591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"117.676843ms","start":"2026-05-20T02:19:48.563253Z","end":"2026-05-20T02:19:48.680929Z","steps":["trace[30529591] 'range keys from in-memory index tree' (duration: 117.343007ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:48.680859Z","caller":"traceutil/trace.go:171","msg":"trace[547785930] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"119.189731ms","start":"2026-05-20T02:19:48.561584Z","end":"2026-05-20T02:19:48.680774Z","steps":["trace[547785930] 'range keys from in-memory index tree' (duration: 118.873445ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:50.38277Z","caller":"traceutil/trace.go:171","msg":"trace[1297781671] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"180.469283ms","start":"2026-05-20T02:19:50.202284Z","end":"2026-05-20T02:19:50.382753Z","steps":["trace[1297781671] 'process raft request' (duration: 180.386722ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:51.040625Z","caller":"traceutil/trace.go:171","msg":"trace[1617103603] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"128.850206ms","start":"2026-05-20T02:19:50.911738Z","end":"2026-05-20T02:19:51.040588Z","steps":["trace[1617103603] 'process raft request' (duration: 106.676682ms)","trace[1617103603] 'compare' (duration: 22.036822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:19:52.865374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.992044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:19:52.865493Z","caller":"traceutil/trace.go:171","msg":"trace[420499585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"252.161816ms","start":"2026-05-20T02:19:52.613305Z","end":"2026-05-20T02:19:52.865467Z","steps":["trace[420499585] 'range keys from in-memory index tree' (duration: 251.80001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:19:52.866136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.226316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:19:52.866215Z","caller":"traceutil/trace.go:171","msg":"trace[1606249855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1073; }","duration":"125.364659ms","start":"2026-05-20T02:19:52.740829Z","end":"2026-05-20T02:19:52.866194Z","steps":["trace[1606249855] 'range keys from in-memory index tree' (duration: 124.656596ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:53.023058Z","caller":"traceutil/trace.go:171","msg":"trace[362120958] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1111; }","duration":"134.922803ms","start":"2026-05-20T02:19:52.888111Z","end":"2026-05-20T02:19:53.023034Z","steps":["trace[362120958] 'read index received' (duration: 2.517589ms)","trace[362120958] 'applied index is now lower than readState.Index' (duration: 132.404244ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:19:53.023385Z","caller":"traceutil/trace.go:171","msg":"trace[1133141124] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"150.278406ms","start":"2026-05-20T02:19:52.873041Z","end":"2026-05-20T02:19:53.02332Z","steps":["trace[1133141124] 'process raft request' (duration: 149.96269ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:53.023504Z","caller":"traceutil/trace.go:171","msg":"trace[1960736085] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"152.603691ms","start":"2026-05-20T02:19:52.870868Z","end":"2026-05-20T02:19:53.023471Z","steps":["trace[1960736085] 'process raft request' (duration: 151.990068ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:19:53.023645Z","caller":"traceutil/trace.go:171","msg":"trace[147310625] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"150.608073ms","start":"2026-05-20T02:19:52.872946Z","end":"2026-05-20T02:19:53.023554Z","steps":["trace[147310625] 'process raft request' (duration: 150.019501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:19:53.023648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.501714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:19:53.023839Z","caller":"traceutil/trace.go:171","msg":"trace[1395496003] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1077; }","duration":"135.741968ms","start":"2026-05-20T02:19:52.888073Z","end":"2026-05-20T02:19:53.023815Z","steps":["trace[1395496003] 'agreement among raft nodes before linearized reading' (duration: 135.457953ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:09.390319Z","caller":"traceutil/trace.go:171","msg":"trace[1845492951] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"474.004012ms","start":"2026-05-20T02:20:08.916289Z","end":"2026-05-20T02:20:09.390293Z","steps":["trace[1845492951] 'read index received' (duration: 438.197022ms)","trace[1845492951] 'applied index is now lower than readState.Index' (duration: 35.80376ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:09.390447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.141356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:20:09.390466Z","caller":"traceutil/trace.go:171","msg":"trace[46179280] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1179; }","duration":"474.226226ms","start":"2026-05-20T02:20:08.916234Z","end":"2026-05-20T02:20:09.39046Z","steps":["trace[46179280] 'agreement among raft nodes before linearized reading' (duration: 474.158455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:09.390486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:08.9162Z","time spent":"474.281728ms","remote":"127.0.0.1:36148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T02:20:09.393475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.207638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T02:20:09.393508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.055321ms","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-05-20T02:20:09.393531Z","caller":"traceutil/trace.go:171","msg":"trace[1168051055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"299.098481ms","start":"2026-05-20T02:20:09.094426Z","end":"2026-05-20T02:20:09.393524Z","steps":["trace[1168051055] 'agreement among raft nodes before linearized reading' (duration: 299.00158ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:09.393531Z","caller":"traceutil/trace.go:171","msg":"trace[319327255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"120.293979ms","start":"2026-05-20T02:20:09.273225Z","end":"2026-05-20T02:20:09.393518Z","steps":["trace[319327255] 'agreement among raft nodes before linearized reading' (duration: 120.197578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:09.393523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.5889ms","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-05-20T02:20:09.3936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.616708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-20T02:20:09.393599Z","caller":"traceutil/trace.go:171","msg":"trace[1869268335] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1180; }","duration":"430.695252ms","start":"2026-05-20T02:20:08.962887Z","end":"2026-05-20T02:20:09.393582Z","steps":["trace[1869268335] 'agreement among raft nodes before linearized reading' (duration: 430.523618ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:09.393618Z","caller":"traceutil/trace.go:171","msg":"trace[1198540388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"294.651538ms","start":"2026-05-20T02:20:09.098962Z","end":"2026-05-20T02:20:09.393613Z","steps":["trace[1198540388] 'agreement among raft nodes before linearized reading' (duration: 294.608437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:09.39363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:08.962875Z","time spent":"430.749193ms","remote":"127.0.0.1:52774","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-05-20T02:20:09.39362Z","caller":"traceutil/trace.go:171","msg":"trace[645394421] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"237.398108ms","start":"2026-05-20T02:20:09.156187Z","end":"2026-05-20T02:20:09.393585Z","steps":["trace[645394421] 'process raft request' (duration: 237.109402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:09.393735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.493754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-20T02:20:09.393819Z","caller":"traceutil/trace.go:171","msg":"trace[2107850942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"303.610586ms","start":"2026-05-20T02:20:09.090189Z","end":"2026-05-20T02:20:09.393799Z","steps":["trace[2107850942] 'agreement among raft nodes before linearized reading' (duration: 303.336711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:09.39386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:09.090176Z","time spent":"303.675938ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T02:20:23.144284Z","caller":"traceutil/trace.go:171","msg":"trace[1645948469] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"224.858854ms","start":"2026-05-20T02:20:22.919401Z","end":"2026-05-20T02:20:23.14426Z","steps":["trace[1645948469] 'read index received' (duration: 224.64394ms)","trace[1645948469] 'applied index is now lower than readState.Index' (duration: 213.964µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:23.144405Z","caller":"traceutil/trace.go:171","msg":"trace[944791093] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"486.890932ms","start":"2026-05-20T02:20:22.657478Z","end":"2026-05-20T02:20:23.144369Z","steps":["trace[944791093] 'process raft request' (duration: 486.634607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:23.144458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.024517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:20:23.144554Z","caller":"traceutil/trace.go:171","msg":"trace[2038873762] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1224; }","duration":"225.14966ms","start":"2026-05-20T02:20:22.919388Z","end":"2026-05-20T02:20:23.144537Z","steps":["trace[2038873762] 'agreement among raft nodes before linearized reading' (duration: 224.970106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:23.144661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:22.657452Z","time spent":"487.108797ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:26.355085Z","caller":"traceutil/trace.go:171","msg":"trace[366777862] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"103.564556ms","start":"2026-05-20T02:20:26.251282Z","end":"2026-05-20T02:20:26.354847Z","steps":["trace[366777862] 'process raft request' (duration: 98.884269ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:28.935808Z","caller":"traceutil/trace.go:171","msg":"trace[1982467337] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"449.721978ms","start":"2026-05-20T02:20:28.486049Z","end":"2026-05-20T02:20:28.935771Z","steps":["trace[1982467337] 'process raft request' (duration: 449.532844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:28.936187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:28.486025Z","time spent":"450.073765ms","remote":"127.0.0.1:52688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5614,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:29.756625Z","caller":"traceutil/trace.go:171","msg":"trace[2033251271] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"179.223621ms","start":"2026-05-20T02:20:29.577376Z","end":"2026-05-20T02:20:29.7566Z","steps":["trace[2033251271] 'read index received' (duration: 179.089008ms)","trace[2033251271] 'applied index is now lower than readState.Index' (duration: 133.283µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:29.756707Z","caller":"traceutil/trace.go:171","msg":"trace[2087903233] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"183.604663ms","start":"2026-05-20T02:20:29.573061Z","end":"2026-05-20T02:20:29.756666Z","steps":["trace[2087903233] 'process raft request' (duration: 183.377739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:29.756876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.445796ms","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-05-20T02:20:29.756876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.694236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:20:29.756917Z","caller":"traceutil/trace.go:171","msg":"trace[1054203644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1305; }","duration":"178.531227ms","start":"2026-05-20T02:20:29.578375Z","end":"2026-05-20T02:20:29.756907Z","steps":["trace[1054203644] 'agreement among raft nodes before linearized reading' (duration: 178.379214ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:29.756929Z","caller":"traceutil/trace.go:171","msg":"trace[535309890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1305; }","duration":"143.817538ms","start":"2026-05-20T02:20:29.613105Z","end":"2026-05-20T02:20:29.756922Z","steps":["trace[535309890] 'agreement among raft nodes before linearized reading' (duration: 143.671066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:29.756972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.395504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-20T02:20:29.756954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.521906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T02:20:29.757156Z","caller":"traceutil/trace.go:171","msg":"trace[1611744519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1305; }","duration":"179.807171ms","start":"2026-05-20T02:20:29.577325Z","end":"2026-05-20T02:20:29.757133Z","steps":["trace[1611744519] 'agreement among raft nodes before linearized reading' (duration: 179.417574ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:29.75705Z","caller":"traceutil/trace.go:171","msg":"trace[1708256905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1305; }","duration":"171.504296ms","start":"2026-05-20T02:20:29.585528Z","end":"2026-05-20T02:20:29.757032Z","steps":["trace[1708256905] 'agreement among raft nodes before linearized reading' (duration: 171.308223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:30.353204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.635698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:20:30.353333Z","caller":"traceutil/trace.go:171","msg":"trace[1777609213] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"593.370593ms","start":"2026-05-20T02:20:29.759941Z","end":"2026-05-20T02:20:30.353312Z","steps":["trace[1777609213] 'process raft request' (duration: 474.514901ms)","trace[1777609213] 'compare' (duration: 118.359974ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:30.35349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:29.759926Z","time spent":"593.458035ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:30.501485Z","caller":"traceutil/trace.go:171","msg":"trace[1888767218] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1353; }","duration":"393.7018ms","start":"2026-05-20T02:20:30.10776Z","end":"2026-05-20T02:20:30.501461Z","steps":["trace[1888767218] 'read index received' (duration: 126.767259ms)","trace[1888767218] 'applied index is now lower than readState.Index' (duration: 266.933231ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:30.501616Z","caller":"traceutil/trace.go:171","msg":"trace[229232306] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"741.629266ms","start":"2026-05-20T02:20:29.759971Z","end":"2026-05-20T02:20:30.501601Z","steps":["trace[229232306] 'process raft request' (duration: 741.205528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:30.501736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:29.759951Z","time spent":"741.712877ms","remote":"127.0.0.1:52774","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-05-20T02:20:30.501916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.222674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:20:30.501973Z","caller":"traceutil/trace.go:171","msg":"trace[377834454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1309; }","duration":"229.337917ms","start":"2026-05-20T02:20:30.272621Z","end":"2026-05-20T02:20:30.501959Z","steps":["trace[377834454] 'agreement among raft nodes before linearized reading' (duration: 229.259466ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:30.502011Z","caller":"traceutil/trace.go:171","msg":"trace[2073907911] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"741.185677ms","start":"2026-05-20T02:20:29.760788Z","end":"2026-05-20T02:20:30.501974Z","steps":["trace[2073907911] 'process raft request' (duration: 740.549595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:30.502175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:29.760779Z","time spent":"741.308969ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:30.502236Z","caller":"traceutil/trace.go:171","msg":"trace[962905354] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"741.314ms","start":"2026-05-20T02:20:29.760902Z","end":"2026-05-20T02:20:30.502215Z","steps":["trace[962905354] 'process raft request' (duration: 740.507214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:30.501987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.22837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2722"} {"level":"info","ts":"2026-05-20T02:20:30.50234Z","caller":"traceutil/trace.go:171","msg":"trace[1526268841] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1309; }","duration":"394.620418ms","start":"2026-05-20T02:20:30.107698Z","end":"2026-05-20T02:20:30.502318Z","steps":["trace[1526268841] 'agreement among raft nodes before linearized reading' (duration: 394.105118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:30.502416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:30.107676Z","time spent":"394.72154ms","remote":"127.0.0.1:52702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2745,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-05-20T02:20:30.502474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:29.760876Z","time spent":"741.414301ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:30.942085Z","caller":"traceutil/trace.go:171","msg":"trace[984432395] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"206.99193ms","start":"2026-05-20T02:20:30.735069Z","end":"2026-05-20T02:20:30.942061Z","steps":["trace[984432395] 'process raft request' (duration: 206.681094ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:32.030232Z","caller":"traceutil/trace.go:171","msg":"trace[2081723383] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1359; }","duration":"183.96743ms","start":"2026-05-20T02:20:31.846242Z","end":"2026-05-20T02:20:32.030209Z","steps":["trace[2081723383] 'read index received' (duration: 183.748916ms)","trace[2081723383] 'applied index is now lower than readState.Index' (duration: 217.384µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:32.030708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.437238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T02:20:32.030817Z","caller":"traceutil/trace.go:171","msg":"trace[1949964347] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"268.759735ms","start":"2026-05-20T02:20:31.761727Z","end":"2026-05-20T02:20:32.030487Z","steps":["trace[1949964347] 'process raft request' (duration: 268.354128ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:32.030845Z","caller":"traceutil/trace.go:171","msg":"trace[733558905] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1312; }","duration":"184.55811ms","start":"2026-05-20T02:20:31.846226Z","end":"2026-05-20T02:20:32.030784Z","steps":["trace[733558905] 'agreement among raft nodes before linearized reading' (duration: 184.375397ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:32.201939Z","caller":"traceutil/trace.go:171","msg":"trace[1182616969] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"167.107814ms","start":"2026-05-20T02:20:32.034799Z","end":"2026-05-20T02:20:32.201906Z","steps":["trace[1182616969] 'process raft request' (duration: 74.421871ms)","trace[1182616969] 'compare' (duration: 92.459719ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:32.59833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.049657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T02:20:32.598394Z","caller":"traceutil/trace.go:171","msg":"trace[700851531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1313; }","duration":"241.135439ms","start":"2026-05-20T02:20:32.357244Z","end":"2026-05-20T02:20:32.598379Z","steps":["trace[700851531] 'range keys from in-memory index tree' (duration: 240.849673ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:32.822351Z","caller":"traceutil/trace.go:171","msg":"trace[1616935016] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"220.643496ms","start":"2026-05-20T02:20:32.60168Z","end":"2026-05-20T02:20:32.822323Z","steps":["trace[1616935016] 'process raft request' (duration: 178.038358ms)","trace[1616935016] 'compare' (duration: 42.420093ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:32.822766Z","caller":"traceutil/trace.go:171","msg":"trace[24930458] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"219.966303ms","start":"2026-05-20T02:20:32.602782Z","end":"2026-05-20T02:20:32.822748Z","steps":["trace[24930458] 'process raft request' (duration: 219.876712ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:32.822807Z","caller":"traceutil/trace.go:171","msg":"trace[476507320] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"220.554434ms","start":"2026-05-20T02:20:32.602229Z","end":"2026-05-20T02:20:32.822783Z","steps":["trace[476507320] 'process raft request' (duration: 220.051685ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:39.269257Z","caller":"traceutil/trace.go:171","msg":"trace[1924637549] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"210.187969ms","start":"2026-05-20T02:20:39.059045Z","end":"2026-05-20T02:20:39.269233Z","steps":["trace[1924637549] 'process raft request' (duration: 210.036997ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:39.319839Z","caller":"traceutil/trace.go:171","msg":"trace[353560211] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"219.140287ms","start":"2026-05-20T02:20:39.100672Z","end":"2026-05-20T02:20:39.319812Z","steps":["trace[353560211] 'process raft request' (duration: 218.979394ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:42.230218Z","caller":"traceutil/trace.go:171","msg":"trace[1964457209] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"171.469996ms","start":"2026-05-20T02:20:42.058718Z","end":"2026-05-20T02:20:42.230188Z","steps":["trace[1964457209] 'process raft request' (duration: 171.295853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:42.822657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.757288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:20:42.822838Z","caller":"traceutil/trace.go:171","msg":"trace[1085847920] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1437; }","duration":"549.33985ms","start":"2026-05-20T02:20:42.273483Z","end":"2026-05-20T02:20:42.822823Z","steps":["trace[1085847920] 'read index received' (duration: 176.296576ms)","trace[1085847920] 'applied index is now lower than readState.Index' (duration: 373.042334ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:42.822925Z","caller":"traceutil/trace.go:171","msg":"trace[931274238] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"588.776217ms","start":"2026-05-20T02:20:42.23414Z","end":"2026-05-20T02:20:42.822916Z","steps":["trace[931274238] 'process raft request' (duration: 588.626245ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:42.822955Z","caller":"traceutil/trace.go:171","msg":"trace[383502438] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"588.979641ms","start":"2026-05-20T02:20:42.233955Z","end":"2026-05-20T02:20:42.822935Z","steps":["trace[383502438] 'process raft request' (duration: 215.807185ms)","trace[383502438] 'compare' (duration: 372.31699ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:42.82299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:42.234119Z","time spent":"588.837568ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:20:42.823043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:42.23393Z","time spent":"589.070402ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:20:42.823265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.757927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:20:42.823363Z","caller":"traceutil/trace.go:171","msg":"trace[830530988] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1389; }","duration":"549.90222ms","start":"2026-05-20T02:20:42.273437Z","end":"2026-05-20T02:20:42.823339Z","steps":["trace[830530988] 'agreement among raft nodes before linearized reading' (duration: 549.727457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:42.823385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.478476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-20T02:20:42.823421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:42.273418Z","time spent":"549.989402ms","remote":"127.0.0.1:52510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T02:20:42.823587Z","caller":"traceutil/trace.go:171","msg":"trace[1054986705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1389; }","duration":"148.68104ms","start":"2026-05-20T02:20:42.674888Z","end":"2026-05-20T02:20:42.823569Z","steps":["trace[1054986705] 'agreement among raft nodes before linearized reading' (duration: 148.300812ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:43.047639Z","caller":"traceutil/trace.go:171","msg":"trace[660055720] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1439; }","duration":"185.174143ms","start":"2026-05-20T02:20:42.862438Z","end":"2026-05-20T02:20:43.047612Z","steps":["trace[660055720] 'read index received' (duration: 184.462649ms)","trace[660055720] 'applied index is now lower than readState.Index' (duration: 710.314µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:43.047855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.374087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:20:43.047941Z","caller":"traceutil/trace.go:171","msg":"trace[1365778036] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1390; }","duration":"185.52752ms","start":"2026-05-20T02:20:42.862391Z","end":"2026-05-20T02:20:43.047919Z","steps":["trace[1365778036] 'agreement among raft nodes before linearized reading' (duration: 185.378647ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:43.047987Z","caller":"traceutil/trace.go:171","msg":"trace[1374692176] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"219.950582ms","start":"2026-05-20T02:20:42.827792Z","end":"2026-05-20T02:20:43.047742Z","steps":["trace[1374692176] 'process raft request' (duration: 219.583396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:43.048257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.272423ms","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-05-20T02:20:43.048334Z","caller":"traceutil/trace.go:171","msg":"trace[1527933635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1390; }","duration":"178.412175ms","start":"2026-05-20T02:20:42.8699Z","end":"2026-05-20T02:20:43.048312Z","steps":["trace[1527933635] 'agreement among raft nodes before linearized reading' (duration: 178.16228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:43.048512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.576769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T02:20:43.048629Z","caller":"traceutil/trace.go:171","msg":"trace[1365642091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1390; }","duration":"178.734941ms","start":"2026-05-20T02:20:42.869872Z","end":"2026-05-20T02:20:43.048607Z","steps":["trace[1365642091] 'agreement among raft nodes before linearized reading' (duration: 178.187161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:43.048787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.969032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:20:43.048855Z","caller":"traceutil/trace.go:171","msg":"trace[721078216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1390; }","duration":"175.063713ms","start":"2026-05-20T02:20:42.873776Z","end":"2026-05-20T02:20:43.048839Z","steps":["trace[721078216] 'agreement among raft nodes before linearized reading' (duration: 174.703216ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:43.1902Z","caller":"traceutil/trace.go:171","msg":"trace[363528136] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"136.845899ms","start":"2026-05-20T02:20:43.053333Z","end":"2026-05-20T02:20:43.190179Z","steps":["trace[363528136] 'process raft request' (duration: 136.799337ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:20:43.190438Z","caller":"traceutil/trace.go:171","msg":"trace[764009397] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"137.572533ms","start":"2026-05-20T02:20:43.052852Z","end":"2026-05-20T02:20:43.190425Z","steps":["trace[764009397] 'process raft request' (duration: 91.160975ms)","trace[764009397] 'compare' (duration: 46.01584ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:43.85299Z","caller":"traceutil/trace.go:171","msg":"trace[22682519] linearizableReadLoop","detail":"{readStateIndex:1444; appliedIndex:1443; }","duration":"465.344679ms","start":"2026-05-20T02:20:43.387617Z","end":"2026-05-20T02:20:43.852962Z","steps":["trace[22682519] 'read index received' (duration: 372.135576ms)","trace[22682519] 'applied index is now lower than readState.Index' (duration: 93.208143ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:20:43.853074Z","caller":"traceutil/trace.go:171","msg":"trace[1940683114] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"573.892589ms","start":"2026-05-20T02:20:43.279146Z","end":"2026-05-20T02:20:43.853039Z","steps":["trace[1940683114] 'process raft request' (duration: 480.654465ms)","trace[1940683114] 'compare' (duration: 93.057351ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:20:43.853308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.198512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-20T02:20:43.853322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:43.279122Z","time spent":"574.041822ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:20:43.853388Z","caller":"traceutil/trace.go:171","msg":"trace[839046043] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:1394; }","duration":"231.331575ms","start":"2026-05-20T02:20:43.622036Z","end":"2026-05-20T02:20:43.853368Z","steps":["trace[839046043] 'agreement among raft nodes before linearized reading' (duration: 231.0952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:43.853491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.880209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-20T02:20:43.853547Z","caller":"traceutil/trace.go:171","msg":"trace[1990881025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1394; }","duration":"465.979222ms","start":"2026-05-20T02:20:43.387559Z","end":"2026-05-20T02:20:43.853538Z","steps":["trace[1990881025] 'agreement among raft nodes before linearized reading' (duration: 465.498353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:20:43.853587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:20:43.387539Z","time spent":"466.039743ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-20T02:20:57.017655Z","caller":"traceutil/trace.go:171","msg":"trace[1497700868] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"110.76224ms","start":"2026-05-20T02:20:56.906864Z","end":"2026-05-20T02:20:57.017626Z","steps":["trace[1497700868] 'process raft request' (duration: 110.522426ms)"],"step_count":1}