{"level":"warn","ts":"2026-08-04T21:35:29.171342Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:29.171474Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-08-04T21:35:29.171555Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:29.171568Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-08-04T21:35:29.171599Z","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-08-04T21:35:29.172253Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-08-04T21:35:29.172337Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-08-04T21:35:29.178083Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.546387ms"} {"level":"info","ts":"2026-08-04T21:35:29.183315Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-08-04T21:35:29.183555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T21:35:29.183684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-08-04T21:35:29.183785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T21:35:29.183862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-08-04T21:35:29.183985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-08-04T21:35:29.193939Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T21:35:29.195676Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T21:35:29.19709Z","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-08-04T21:35:29.199199Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T21:35:29.201641Z","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-08-04T21:35:29.201757Z","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-08-04T21:35:29.201726Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T21:35:29.202286Z","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-08-04T21:35:29.202673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-08-04T21:35:29.202874Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-08-04T21:35:29.204887Z","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-08-04T21:35:29.204994Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-08-04T21:35:29.205057Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-08-04T21:35:29.2054Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T21:35:29.205534Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T21:35:29.884348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T21:35:29.884406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T21:35:29.884445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-08-04T21:35:29.884465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-08-04T21:35:29.884477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-08-04T21:35:29.884493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-08-04T21:35:29.884507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-08-04T21:35:29.886001Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T21:35:29.88603Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:35:29.886288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:35:29.886576Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:29.886852Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T21:35:29.886886Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T21:35:29.887735Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:29.887843Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:29.887874Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:29.890165Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-08-04T21:35:29.890526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-04T21:35:34.257791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.923023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-08-04T21:35:34.257838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.918258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-08-04T21:35:34.257914Z","caller":"traceutil/trace.go:171","msg":"trace[215223516] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:271; }","duration":"446.108718ms","start":"2026-08-04T21:35:33.811785Z","end":"2026-08-04T21:35:34.257894Z","steps":["trace[215223516] 'range keys from in-memory index tree' (duration: 445.806549ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:35:34.257929Z","caller":"traceutil/trace.go:171","msg":"trace[373343278] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:271; }","duration":"352.085682ms","start":"2026-08-04T21:35:33.905822Z","end":"2026-08-04T21:35:34.257907Z","steps":["trace[373343278] 'range keys from in-memory index tree' (duration: 351.770573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:35:34.258004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:35:33.905799Z","time spent":"352.195705ms","remote":"127.0.0.1:43218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3731,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-04T21:35:34.258129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:35:33.811758Z","time spent":"446.209731ms","remote":"127.0.0.1:43152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-04T21:35:34.492187Z","caller":"traceutil/trace.go:171","msg":"trace[1718182585] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"229.756874ms","start":"2026-08-04T21:35:34.262387Z","end":"2026-08-04T21:35:34.492144Z","steps":["trace[1718182585] 'process raft request' (duration: 229.507747ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:35:34.984876Z","caller":"traceutil/trace.go:171","msg":"trace[1904719648] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:278; }","duration":"489.065505ms","start":"2026-08-04T21:35:34.495785Z","end":"2026-08-04T21:35:34.98485Z","steps":["trace[1904719648] 'read index received' (duration: 488.725346ms)","trace[1904719648] 'applied index is now lower than readState.Index' (duration: 339.039µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:35:34.98494Z","caller":"traceutil/trace.go:171","msg":"trace[1873797406] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"718.716986ms","start":"2026-08-04T21:35:34.266198Z","end":"2026-08-04T21:35:34.984915Z","steps":["trace[1873797406] 'process raft request' (duration: 718.411197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:35:34.985067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.21559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-08-04T21:35:34.98511Z","caller":"traceutil/trace.go:171","msg":"trace[1358925413] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:273; }","duration":"489.371424ms","start":"2026-08-04T21:35:34.495725Z","end":"2026-08-04T21:35:34.985097Z","steps":["trace[1358925413] 'agreement among raft nodes before linearized reading' (duration: 489.2208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:35:34.985208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:35:34.495701Z","time spent":"489.472276ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" "} {"level":"warn","ts":"2026-08-04T21:35:34.985842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:35:34.266171Z","time spent":"718.82938ms","remote":"127.0.0.1:43218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:36:06.772944Z","caller":"traceutil/trace.go:171","msg":"trace[1650808111] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"961.784976ms","start":"2026-08-04T21:36:05.811132Z","end":"2026-08-04T21:36:06.772917Z","steps":["trace[1650808111] 'process raft request' (duration: 961.620252ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.773122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.811113Z","time spent":"961.938071ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.779993Z","caller":"traceutil/trace.go:171","msg":"trace[606170412] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"966.717935ms","start":"2026-08-04T21:36:05.813249Z","end":"2026-08-04T21:36:06.779967Z","steps":["trace[606170412] 'process raft request' (duration: 966.390516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.780105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.813233Z","time spent":"966.823668ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.780102Z","caller":"traceutil/trace.go:171","msg":"trace[1666675513] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"936.838182ms","start":"2026-08-04T21:36:05.843176Z","end":"2026-08-04T21:36:06.780014Z","steps":["trace[1666675513] 'process raft request' (duration: 936.571815ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:06.780282Z","caller":"traceutil/trace.go:171","msg":"trace[1607786795] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"922.57838ms","start":"2026-08-04T21:36:05.857681Z","end":"2026-08-04T21:36:06.780259Z","steps":["trace[1607786795] 'process raft request' (duration: 922.254611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.780351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.843163Z","time spent":"937.07323ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:06.780423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.857674Z","time spent":"922.685204ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.780471Z","caller":"traceutil/trace.go:171","msg":"trace[212058533] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"917.733885ms","start":"2026-08-04T21:36:05.862715Z","end":"2026-08-04T21:36:06.780448Z","steps":["trace[212058533] 'process raft request' (duration: 917.270871ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:06.780515Z","caller":"traceutil/trace.go:171","msg":"trace[47434319] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"784.849008ms","start":"2026-08-04T21:36:05.995653Z","end":"2026-08-04T21:36:06.780502Z","steps":["trace[47434319] 'process raft request' (duration: 784.507598ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:06.780553Z","caller":"traceutil/trace.go:171","msg":"trace[1609535363] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"937.156121ms","start":"2026-08-04T21:36:05.843389Z","end":"2026-08-04T21:36:06.780545Z","steps":["trace[1609535363] 'process raft request' (duration: 936.431521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.780581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.995617Z","time spent":"784.93479ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:06.780599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.8627Z","time spent":"917.845727ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.780616Z","caller":"traceutil/trace.go:171","msg":"trace[1577519624] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"930.974067ms","start":"2026-08-04T21:36:05.849637Z","end":"2026-08-04T21:36:06.780611Z","steps":["trace[1577519624] 'process raft request' (duration: 930.214446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.780643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.84961Z","time spent":"931.021419ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.780698Z","caller":"traceutil/trace.go:171","msg":"trace[559339184] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"923.373563ms","start":"2026-08-04T21:36:05.857319Z","end":"2026-08-04T21:36:06.780693Z","steps":["trace[559339184] 'process raft request' (duration: 922.580391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.78073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.857292Z","time spent":"923.423714ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.78077Z","caller":"traceutil/trace.go:171","msg":"trace[373891141] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"683.442028ms","start":"2026-08-04T21:36:06.097321Z","end":"2026-08-04T21:36:06.780763Z","steps":["trace[373891141] 'process raft request' (duration: 682.904623ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:06.780787Z","caller":"traceutil/trace.go:171","msg":"trace[385399139] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"895.765515ms","start":"2026-08-04T21:36:05.885014Z","end":"2026-08-04T21:36:06.78078Z","steps":["trace[385399139] 'process raft request' (duration: 895.081976ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:06.780783Z","caller":"traceutil/trace.go:171","msg":"trace[1808602250] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"916.909061ms","start":"2026-08-04T21:36:05.863858Z","end":"2026-08-04T21:36:06.780767Z","steps":["trace[1808602250] 'process raft request' (duration: 916.17718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.780813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.884979Z","time spent":"895.821916ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:06.780822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:06.097289Z","time spent":"683.50403ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:36:06.780913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.863838Z","time spent":"916.987043ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:06.780592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.843346Z","time spent":"937.232344ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:06.781752Z","caller":"traceutil/trace.go:171","msg":"trace[80726332] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"938.402687ms","start":"2026-08-04T21:36:05.843324Z","end":"2026-08-04T21:36:06.781726Z","steps":["trace[80726332] 'process raft request' (duration: 936.469362ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:06.781871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:05.843301Z","time spent":"938.5257ms","remote":"127.0.0.1:43096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:12.692506Z","caller":"traceutil/trace.go:171","msg":"trace[467686432] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"113.209601ms","start":"2026-08-04T21:36:12.579256Z","end":"2026-08-04T21:36:12.692465Z","steps":["trace[467686432] 'process raft request' (duration: 112.075029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:13.134883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.816563ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-04T21:36:13.135024Z","caller":"traceutil/trace.go:171","msg":"trace[1330866843] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"103.414516ms","start":"2026-08-04T21:36:13.031586Z","end":"2026-08-04T21:36:13.135001Z","steps":["trace[1330866843] 'read index received' (duration: 59.802µs)","trace[1330866843] 'applied index is now lower than readState.Index' (duration: 103.352514ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:13.135135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.528129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:36:13.135172Z","caller":"traceutil/trace.go:171","msg":"trace[381951379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"103.638093ms","start":"2026-08-04T21:36:13.031521Z","end":"2026-08-04T21:36:13.135159Z","steps":["trace[381951379] 'agreement among raft nodes before linearized reading' (duration: 103.54191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:13.916145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398342511706350957,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T21:36:14.094842Z","caller":"traceutil/trace.go:171","msg":"trace[1657018999] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"679.389914ms","start":"2026-08-04T21:36:13.415423Z","end":"2026-08-04T21:36:14.094813Z","steps":["trace[1657018999] 'read index received' (duration: 665.503533ms)","trace[1657018999] 'applied index is now lower than readState.Index' (duration: 13.884751ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:36:14.094994Z","caller":"traceutil/trace.go:171","msg":"trace[1476006308] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"881.960286ms","start":"2026-08-04T21:36:13.213018Z","end":"2026-08-04T21:36:14.094978Z","steps":["trace[1476006308] 'process raft request' (duration: 868.088885ms)","trace[1476006308] 'compare' (duration: 13.301675ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:14.095115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:13.212989Z","time spent":"882.040387ms","remote":"127.0.0.1:43130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036153,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:36:14.095404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.985022ms","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-08-04T21:36:14.095435Z","caller":"traceutil/trace.go:171","msg":"trace[44145001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"680.016033ms","start":"2026-08-04T21:36:13.415409Z","end":"2026-08-04T21:36:14.095425Z","steps":["trace[44145001] 'agreement among raft nodes before linearized reading' (duration: 679.950621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:14.095462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:13.415349Z","time spent":"680.107234ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:36:14.095504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.425905ms","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-08-04T21:36:14.095553Z","caller":"traceutil/trace.go:171","msg":"trace[2111144748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"463.503228ms","start":"2026-08-04T21:36:13.632036Z","end":"2026-08-04T21:36:14.09554Z","steps":["trace[2111144748] 'agreement among raft nodes before linearized reading' (duration: 463.419175ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:14.095533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.042481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-04T21:36:14.095576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:13.632026Z","time spent":"463.545979ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:36:14.095569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.01342ms","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-08-04T21:36:14.095605Z","caller":"traceutil/trace.go:171","msg":"trace[558597690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"487.148964ms","start":"2026-08-04T21:36:13.608434Z","end":"2026-08-04T21:36:14.095583Z","steps":["trace[558597690] 'agreement among raft nodes before linearized reading' (duration: 487.0109ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:14.095623Z","caller":"traceutil/trace.go:171","msg":"trace[617066482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"465.088863ms","start":"2026-08-04T21:36:13.630517Z","end":"2026-08-04T21:36:14.095606Z","steps":["trace[617066482] 'agreement among raft nodes before linearized reading' (duration: 464.97718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:14.095655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:13.608414Z","time spent":"487.232587ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:36:14.095667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:13.630505Z","time spent":"465.154064ms","remote":"127.0.0.1:43298","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-08-04T21:36:26.951586Z","caller":"traceutil/trace.go:171","msg":"trace[917061128] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"179.10381ms","start":"2026-08-04T21:36:26.772453Z","end":"2026-08-04T21:36:26.951556Z","steps":["trace[917061128] 'process raft request' (duration: 178.915855ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:59.876952Z","caller":"traceutil/trace.go:171","msg":"trace[622242748] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"111.8435ms","start":"2026-08-04T21:36:59.765074Z","end":"2026-08-04T21:36:59.876918Z","steps":["trace[622242748] 'read index received' (duration: 111.627434ms)","trace[622242748] 'applied index is now lower than readState.Index' (duration: 214.946µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:36:59.877021Z","caller":"traceutil/trace.go:171","msg":"trace[1209763842] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"140.354324ms","start":"2026-08-04T21:36:59.736624Z","end":"2026-08-04T21:36:59.876978Z","steps":["trace[1209763842] 'process raft request' (duration: 140.101347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:59.877149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.035946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:36:59.877204Z","caller":"traceutil/trace.go:171","msg":"trace[686900743] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:995; }","duration":"112.18275ms","start":"2026-08-04T21:36:59.765009Z","end":"2026-08-04T21:36:59.877192Z","steps":["trace[686900743] 'agreement among raft nodes before linearized reading' (duration: 112.032706ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:06.071473Z","caller":"traceutil/trace.go:171","msg":"trace[1104397023] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"136.023612ms","start":"2026-08-04T21:37:05.935419Z","end":"2026-08-04T21:37:06.071443Z","steps":["trace[1104397023] 'process raft request' (duration: 135.804956ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:06.67726Z","caller":"traceutil/trace.go:171","msg":"trace[412220674] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"306.661749ms","start":"2026-08-04T21:37:06.37057Z","end":"2026-08-04T21:37:06.677231Z","steps":["trace[412220674] 'read index received' (duration: 306.413472ms)","trace[412220674] 'applied index is now lower than readState.Index' (duration: 247.207µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:37:06.677491Z","caller":"traceutil/trace.go:171","msg":"trace[2145915273] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"500.422938ms","start":"2026-08-04T21:37:06.176921Z","end":"2026-08-04T21:37:06.677344Z","steps":["trace[2145915273] 'process raft request' (duration: 500.14673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:06.677589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.998048ms","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-08-04T21:37:06.677541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.77504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-04T21:37:06.677693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.23733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T21:37:06.677724Z","caller":"traceutil/trace.go:171","msg":"trace[422480112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1020; }","duration":"307.163703ms","start":"2026-08-04T21:37:06.370521Z","end":"2026-08-04T21:37:06.677685Z","steps":["trace[422480112] 'agreement among raft nodes before linearized reading' (duration: 306.864944ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:06.677745Z","caller":"traceutil/trace.go:171","msg":"trace[856563419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1020; }","duration":"299.365384ms","start":"2026-08-04T21:37:06.378361Z","end":"2026-08-04T21:37:06.677726Z","steps":["trace[856563419] 'agreement among raft nodes before linearized reading' (duration: 299.208769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:06.67778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:06.370496Z","time spent":"307.274116ms","remote":"127.0.0.1:43298","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-08-04T21:37:06.677779Z","caller":"traceutil/trace.go:171","msg":"trace[1820439938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1020; }","duration":"303.023207ms","start":"2026-08-04T21:37:06.374704Z","end":"2026-08-04T21:37:06.677728Z","steps":["trace[1820439938] 'agreement among raft nodes before linearized reading' (duration: 302.694788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:06.678051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:06.374687Z","time spent":"303.301154ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:37:06.678363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.391046ms","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-08-04T21:37:06.678431Z","caller":"traceutil/trace.go:171","msg":"trace[1953539448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1020; }","duration":"298.469678ms","start":"2026-08-04T21:37:06.379944Z","end":"2026-08-04T21:37:06.678414Z","steps":["trace[1953539448] 'agreement among raft nodes before linearized reading' (duration: 297.587563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:06.678411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:06.176899Z","time spent":"500.699875ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:37:28.65111Z","caller":"traceutil/trace.go:171","msg":"trace[414662038] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"350.051182ms","start":"2026-08-04T21:37:28.301024Z","end":"2026-08-04T21:37:28.651076Z","steps":["trace[414662038] 'process raft request' (duration: 349.847526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.651313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:28.300997Z","time spent":"350.201506ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:37:28.947979Z","caller":"traceutil/trace.go:171","msg":"trace[1833322875] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"236.38956ms","start":"2026-08-04T21:37:28.711569Z","end":"2026-08-04T21:37:28.947959Z","steps":["trace[1833322875] 'process raft request' (duration: 236.225896ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:28.948133Z","caller":"traceutil/trace.go:171","msg":"trace[1631307168] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1131; }","duration":"157.391854ms","start":"2026-08-04T21:37:28.790733Z","end":"2026-08-04T21:37:28.948124Z","steps":["trace[1631307168] 'read index received' (duration: 83.342988ms)","trace[1631307168] 'applied index is now lower than readState.Index' (duration: 74.048376ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:37:28.948244Z","caller":"traceutil/trace.go:171","msg":"trace[1160775901] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"189.673754ms","start":"2026-08-04T21:37:28.758564Z","end":"2026-08-04T21:37:28.948238Z","steps":["trace[1160775901] 'process raft request' (duration: 189.347945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.948387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.636441ms","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-08-04T21:37:28.948415Z","caller":"traceutil/trace.go:171","msg":"trace[1280182825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1093; }","duration":"157.704993ms","start":"2026-08-04T21:37:28.790703Z","end":"2026-08-04T21:37:28.948408Z","steps":["trace[1280182825] 'agreement among raft nodes before linearized reading' (duration: 157.59309ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.948512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.359477ms","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-08-04T21:37:28.948534Z","caller":"traceutil/trace.go:171","msg":"trace[1846434375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1093; }","duration":"155.393228ms","start":"2026-08-04T21:37:28.793135Z","end":"2026-08-04T21:37:28.948528Z","steps":["trace[1846434375] 'agreement among raft nodes before linearized reading' (duration: 155.338137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.94866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.386158ms","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-08-04T21:37:28.94874Z","caller":"traceutil/trace.go:171","msg":"trace[1147235935] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1093; }","duration":"111.503261ms","start":"2026-08-04T21:37:28.837205Z","end":"2026-08-04T21:37:28.948709Z","steps":["trace[1147235935] 'agreement among raft nodes before linearized reading' (duration: 111.351427ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.948847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.416969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T21:37:28.948873Z","caller":"traceutil/trace.go:171","msg":"trace[1293388407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1093; }","duration":"144.45047ms","start":"2026-08-04T21:37:28.804415Z","end":"2026-08-04T21:37:28.948865Z","steps":["trace[1293388407] 'agreement among raft nodes before linearized reading' (duration: 144.375298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:28.948851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.46977ms","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-08-04T21:37:28.948944Z","caller":"traceutil/trace.go:171","msg":"trace[649695796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1093; }","duration":"144.608914ms","start":"2026-08-04T21:37:28.804313Z","end":"2026-08-04T21:37:28.948922Z","steps":["trace[649695796] 'agreement among raft nodes before linearized reading' (duration: 144.351047ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:51.153356Z","caller":"traceutil/trace.go:171","msg":"trace[2041274815] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"254.555804ms","start":"2026-08-04T21:37:50.898772Z","end":"2026-08-04T21:37:51.153328Z","steps":["trace[2041274815] 'process raft request' (duration: 254.378959ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:51.163459Z","caller":"traceutil/trace.go:171","msg":"trace[1691297408] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1261; }","duration":"130.111896ms","start":"2026-08-04T21:37:51.033327Z","end":"2026-08-04T21:37:51.163439Z","steps":["trace[1691297408] 'read index received' (duration: 119.90579ms)","trace[1691297408] 'applied index is now lower than readState.Index' (duration: 10.205256ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:37:51.163666Z","caller":"traceutil/trace.go:171","msg":"trace[136898972] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"146.977919ms","start":"2026-08-04T21:37:51.016675Z","end":"2026-08-04T21:37:51.163653Z","steps":["trace[136898972] 'process raft request' (duration: 146.66988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:51.163846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.505848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:37:51.163884Z","caller":"traceutil/trace.go:171","msg":"trace[224393222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"130.59073ms","start":"2026-08-04T21:37:51.033283Z","end":"2026-08-04T21:37:51.163873Z","steps":["trace[224393222] 'agreement among raft nodes before linearized reading' (duration: 130.527408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:51.164065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.317675ms","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-08-04T21:37:51.164118Z","caller":"traceutil/trace.go:171","msg":"trace[1834984584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1216; }","duration":"103.404728ms","start":"2026-08-04T21:37:51.0607Z","end":"2026-08-04T21:37:51.164105Z","steps":["trace[1834984584] 'agreement among raft nodes before linearized reading' (duration: 103.258484ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:51.164236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.608337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-04T21:37:51.164252Z","caller":"traceutil/trace.go:171","msg":"trace[717362838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"101.650169ms","start":"2026-08-04T21:37:51.062598Z","end":"2026-08-04T21:37:51.164248Z","steps":["trace[717362838] 'agreement among raft nodes before linearized reading' (duration: 101.604867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:51.16427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.620928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-04T21:37:51.164316Z","caller":"traceutil/trace.go:171","msg":"trace[618408833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"101.692179ms","start":"2026-08-04T21:37:51.062615Z","end":"2026-08-04T21:37:51.164308Z","steps":["trace[618408833] 'agreement among raft nodes before linearized reading' (duration: 101.577406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.178566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.732782ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-04T21:38:08.178682Z","caller":"traceutil/trace.go:171","msg":"trace[406288446] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"142.882305ms","start":"2026-08-04T21:38:08.035781Z","end":"2026-08-04T21:38:08.178664Z","steps":["trace[406288446] 'read index received' (duration: 84.873µs)","trace[406288446] 'applied index is now lower than readState.Index' (duration: 142.795871ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:08.179287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.507171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:08.179643Z","caller":"traceutil/trace.go:171","msg":"trace[1183921491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1300; }","duration":"143.925254ms","start":"2026-08-04T21:38:08.035702Z","end":"2026-08-04T21:38:08.179628Z","steps":["trace[1183921491] 'agreement among raft nodes before linearized reading' (duration: 143.006838ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:09.729957Z","caller":"traceutil/trace.go:171","msg":"trace[1096087360] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"506.125743ms","start":"2026-08-04T21:38:09.223795Z","end":"2026-08-04T21:38:09.729921Z","steps":["trace[1096087360] 'process raft request' (duration: 505.900576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:09.730161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.223769Z","time spent":"506.287538ms","remote":"127.0.0.1:43218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5926,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:09.771076Z","caller":"traceutil/trace.go:171","msg":"trace[1123449186] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1351; }","duration":"468.107798ms","start":"2026-08-04T21:38:09.30293Z","end":"2026-08-04T21:38:09.771037Z","steps":["trace[1123449186] 'read index received' (duration: 426.828581ms)","trace[1123449186] 'applied index is now lower than readState.Index' (duration: 41.278297ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:09.771448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.481008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-04T21:38:09.771508Z","caller":"traceutil/trace.go:171","msg":"trace[1376762554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1302; }","duration":"468.635653ms","start":"2026-08-04T21:38:09.302856Z","end":"2026-08-04T21:38:09.771491Z","steps":["trace[1376762554] 'agreement among raft nodes before linearized reading' (duration: 468.407366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:09.771565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.302827Z","time spent":"468.725335ms","remote":"127.0.0.1:43298","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-08-04T21:38:09.77145Z","caller":"traceutil/trace.go:171","msg":"trace[1074297376] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"493.213231ms","start":"2026-08-04T21:38:09.278189Z","end":"2026-08-04T21:38:09.771403Z","steps":["trace[1074297376] 'process raft request' (duration: 491.495153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:09.771924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.278168Z","time spent":"493.580722ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:10.193162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.608761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:10.193354Z","caller":"traceutil/trace.go:171","msg":"trace[842584628] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"410.804152ms","start":"2026-08-04T21:38:09.78253Z","end":"2026-08-04T21:38:10.193335Z","steps":["trace[842584628] 'process raft request' (duration: 410.741971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.19343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.782505Z","time spent":"410.888215ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:10.193792Z","caller":"traceutil/trace.go:171","msg":"trace[999439562] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"452.83184ms","start":"2026-08-04T21:38:09.740946Z","end":"2026-08-04T21:38:10.193778Z","steps":["trace[999439562] 'process raft request' (duration: 175.494838ms)","trace[999439562] 'compare' (duration: 276.459997ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:10.193849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.740917Z","time spent":"452.901802ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:10.193976Z","caller":"traceutil/trace.go:171","msg":"trace[89727671] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"422.794178ms","start":"2026-08-04T21:38:09.771172Z","end":"2026-08-04T21:38:10.193966Z","steps":["trace[89727671] 'read index received' (duration: 145.473106ms)","trace[89727671] 'applied index is now lower than readState.Index' (duration: 277.319882ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:10.194243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.092368ms","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-08-04T21:38:10.194282Z","caller":"traceutil/trace.go:171","msg":"trace[1397768691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1304; }","duration":"832.14867ms","start":"2026-08-04T21:38:09.362121Z","end":"2026-08-04T21:38:10.194269Z","steps":["trace[1397768691] 'agreement among raft nodes before linearized reading' (duration: 832.001775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.194312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.362112Z","time spent":"832.193382ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:10.194511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.411267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T21:38:10.194546Z","caller":"traceutil/trace.go:171","msg":"trace[713816779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"832.474209ms","start":"2026-08-04T21:38:09.36206Z","end":"2026-08-04T21:38:10.194535Z","steps":["trace[713816779] 'agreement among raft nodes before linearized reading' (duration: 832.388027ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.194581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.362048Z","time spent":"832.52421ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:10.194766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.224476ms","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-08-04T21:38:10.194849Z","caller":"traceutil/trace.go:171","msg":"trace[1924344551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1304; }","duration":"835.309538ms","start":"2026-08-04T21:38:09.359529Z","end":"2026-08-04T21:38:10.194838Z","steps":["trace[1924344551] 'agreement among raft nodes before linearized reading' (duration: 835.172615ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.194883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.359451Z","time spent":"835.423411ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-04T21:38:10.195057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.475876ms","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-08-04T21:38:10.195086Z","caller":"traceutil/trace.go:171","msg":"trace[84978039] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1304; }","duration":"879.541248ms","start":"2026-08-04T21:38:09.315534Z","end":"2026-08-04T21:38:10.195075Z","steps":["trace[84978039] 'agreement among raft nodes before linearized reading' (duration: 879.461496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.195113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:09.315508Z","time spent":"879.59999ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:38:10.195248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.730453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:10.195286Z","caller":"traceutil/trace.go:171","msg":"trace[1402443713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1304; }","duration":"161.815455ms","start":"2026-08-04T21:38:10.03346Z","end":"2026-08-04T21:38:10.195276Z","steps":["trace[1402443713] 'agreement among raft nodes before linearized reading' (duration: 161.760803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:10.44667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.322041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:10.446964Z","caller":"traceutil/trace.go:171","msg":"trace[1418858295] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"244.513081ms","start":"2026-08-04T21:38:10.202415Z","end":"2026-08-04T21:38:10.446928Z","steps":["trace[1418858295] 'process raft request' (duration: 133.829719ms)","trace[1418858295] 'compare' (duration: 110.064504ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:10.447021Z","caller":"traceutil/trace.go:171","msg":"trace[132272279] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"243.317277ms","start":"2026-08-04T21:38:10.203668Z","end":"2026-08-04T21:38:10.446986Z","steps":["trace[132272279] 'process raft request' (duration: 243.104861ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:10.447205Z","caller":"traceutil/trace.go:171","msg":"trace[1347336645] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"238.585205ms","start":"2026-08-04T21:38:10.208596Z","end":"2026-08-04T21:38:10.447181Z","steps":["trace[1347336645] 'process raft request' (duration: 238.306647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:17.363477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.270981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:17.363623Z","caller":"traceutil/trace.go:171","msg":"trace[1262692] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1412; }","duration":"892.239223ms","start":"2026-08-04T21:38:16.471361Z","end":"2026-08-04T21:38:17.363601Z","steps":["trace[1262692] 'read index received' (duration: 53.011µs)","trace[1262692] 'applied index is now lower than readState.Index' (duration: 892.184222ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:17.363742Z","caller":"traceutil/trace.go:171","msg":"trace[2085928986] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"1.107875957s","start":"2026-08-04T21:38:16.255784Z","end":"2026-08-04T21:38:17.36366Z","steps":["trace[2085928986] 'process raft request' (duration: 127.330279ms)","trace[2085928986] 'compare' (duration: 979.997372ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:17.363886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.506271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-04T21:38:17.36394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:16.255773Z","time spent":"1.108053241s","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:17.363922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.015452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:17.363974Z","caller":"traceutil/trace.go:171","msg":"trace[1818141022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1361; }","duration":"892.647985ms","start":"2026-08-04T21:38:16.471306Z","end":"2026-08-04T21:38:17.363954Z","steps":["trace[1818141022] 'agreement among raft nodes before linearized reading' (duration: 892.410838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:17.36401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.270104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-04T21:38:17.36403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:16.471281Z","time spent":"892.736948ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-04T21:38:17.364028Z","caller":"traceutil/trace.go:171","msg":"trace[572245427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1361; }","duration":"328.181286ms","start":"2026-08-04T21:38:17.035823Z","end":"2026-08-04T21:38:17.364005Z","steps":["trace[572245427] 'agreement among raft nodes before linearized reading' (duration: 328.029502ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:17.364075Z","caller":"traceutil/trace.go:171","msg":"trace[655334221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1361; }","duration":"892.348917ms","start":"2026-08-04T21:38:16.471709Z","end":"2026-08-04T21:38:17.364058Z","steps":["trace[655334221] 'agreement among raft nodes before linearized reading' (duration: 892.11521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:17.364082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:17.035794Z","time spent":"328.280419ms","remote":"127.0.0.1:43050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T21:38:17.364114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.390085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-08-04T21:38:17.364128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:16.471703Z","time spent":"892.415708ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:17.364011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.264535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-08-04T21:38:17.364306Z","caller":"traceutil/trace.go:171","msg":"trace[422491418] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1361; }","duration":"598.556633ms","start":"2026-08-04T21:38:16.765695Z","end":"2026-08-04T21:38:17.364252Z","steps":["trace[422491418] 'agreement among raft nodes before linearized reading' (duration: 598.164502ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:17.364165Z","caller":"traceutil/trace.go:171","msg":"trace[554415253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1361; }","duration":"888.456267ms","start":"2026-08-04T21:38:16.475695Z","end":"2026-08-04T21:38:17.364152Z","steps":["trace[554415253] 'agreement among raft nodes before linearized reading' (duration: 888.358525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:17.364534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:16.475685Z","time spent":"888.838448ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:17.366312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:16.765672Z","time spent":"598.7918ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}