{"level":"warn","ts":"2026-04-20T08:12:45.941305Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:12:45.94142Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.246:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.246:2380","--initial-cluster=instance=https://199.19.213.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.246:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T08:12:45.941679Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:12:45.941703Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.246:2380"]} {"level":"info","ts":"2026-04-20T08:12:45.94181Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:12:45.942845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.246:2379"]} {"level":"info","ts":"2026-04-20T08:12:45.942949Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.246:2380"],"listen-peer-urls":["https://199.19.213.246:2380"],"advertise-client-urls":["https://199.19.213.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.246:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T08:12:45.950122Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.903052ms"} {"level":"info","ts":"2026-04-20T08:12:45.956853Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2b4fc23d90360acd","cluster-id":"fbafe76a301d853c"} {"level":"info","ts":"2026-04-20T08:12:45.956953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:12:45.956978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd became follower at term 0"} {"level":"info","ts":"2026-04-20T08:12:45.95699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2b4fc23d90360acd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:12:45.957001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd became follower at term 1"} {"level":"info","ts":"2026-04-20T08:12:45.957037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd switched to configuration voters=(3120926636459297485)"} {"level":"warn","ts":"2026-04-20T08:12:45.965357Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:12:45.968767Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:12:45.97072Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T08:12:45.97408Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2b4fc23d90360acd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:12:45.974959Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2b4fc23d90360acd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:12:45.975241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd switched to configuration voters=(3120926636459297485)"} {"level":"info","ts":"2026-04-20T08:12:45.975382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fbafe76a301d853c","local-member-id":"2b4fc23d90360acd","added-peer-id":"2b4fc23d90360acd","added-peer-peer-urls":["https://199.19.213.246:2380"]} {"level":"info","ts":"2026-04-20T08:12:45.975449Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:12:45.975475Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:12:45.975484Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:12:45.984675Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:12:45.984855Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.246:2380"} {"level":"info","ts":"2026-04-20T08:12:45.984901Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.246:2380"} {"level":"info","ts":"2026-04-20T08:12:45.98517Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2b4fc23d90360acd","initial-advertise-peer-urls":["https://199.19.213.246:2380"],"listen-peer-urls":["https://199.19.213.246:2380"],"advertise-client-urls":["https://199.19.213.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:12:45.985222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:12:46.157545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:12:46.157652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:12:46.157681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd received MsgPreVoteResp from 2b4fc23d90360acd at term 1"} {"level":"info","ts":"2026-04-20T08:12:46.157695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:12:46.157703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd received MsgVoteResp from 2b4fc23d90360acd at term 2"} {"level":"info","ts":"2026-04-20T08:12:46.157714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b4fc23d90360acd became leader at term 2"} {"level":"info","ts":"2026-04-20T08:12:46.15774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2b4fc23d90360acd elected leader 2b4fc23d90360acd at term 2"} {"level":"info","ts":"2026-04-20T08:12:46.159154Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:12:46.159435Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2b4fc23d90360acd","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.246:2379]}","request-path":"/0/members/2b4fc23d90360acd/attributes","cluster-id":"fbafe76a301d853c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:12:46.15944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:12:46.159467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:12:46.159671Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:12:46.159712Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:12:46.160184Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fbafe76a301d853c","local-member-id":"2b4fc23d90360acd","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:12:46.160264Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:12:46.16031Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:12:46.162028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.246:2379"} {"level":"info","ts":"2026-04-20T08:12:46.162567Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T08:13:16.351407Z","caller":"traceutil/trace.go:171","msg":"trace[546641691] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"177.24574ms","start":"2026-04-20T08:13:16.174137Z","end":"2026-04-20T08:13:16.351382Z","steps":["trace[546641691] 'process raft request' (duration: 176.727658ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:16.427081Z","caller":"traceutil/trace.go:171","msg":"trace[1577924757] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:489; }","duration":"142.277298ms","start":"2026-04-20T08:13:16.284783Z","end":"2026-04-20T08:13:16.427061Z","steps":["trace[1577924757] 'read index received' (duration: 66.25026ms)","trace[1577924757] 'applied index is now lower than readState.Index' (duration: 76.026128ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:16.427121Z","caller":"traceutil/trace.go:171","msg":"trace[159998140] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"252.204304ms","start":"2026-04-20T08:13:16.174885Z","end":"2026-04-20T08:13:16.427089Z","steps":["trace[159998140] 'process raft request' (duration: 250.643228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:16.427236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.435352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T08:13:16.427306Z","caller":"traceutil/trace.go:171","msg":"trace[773729690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"142.573985ms","start":"2026-04-20T08:13:16.284719Z","end":"2026-04-20T08:13:16.427293Z","steps":["trace[773729690] 'agreement among raft nodes before linearized reading' (duration: 142.426071ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.442233Z","caller":"traceutil/trace.go:171","msg":"trace[861301609] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"206.676433ms","start":"2026-04-20T08:13:17.23553Z","end":"2026-04-20T08:13:17.442207Z","steps":["trace[861301609] 'process raft request' (duration: 206.53553ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.4507Z","caller":"traceutil/trace.go:171","msg":"trace[1090118967] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"214.786773ms","start":"2026-04-20T08:13:17.235884Z","end":"2026-04-20T08:13:17.450671Z","steps":["trace[1090118967] 'process raft request' (duration: 214.594209ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.450958Z","caller":"traceutil/trace.go:171","msg":"trace[1666082375] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"174.322351ms","start":"2026-04-20T08:13:17.276623Z","end":"2026-04-20T08:13:17.450946Z","steps":["trace[1666082375] 'process raft request' (duration: 174.114397ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.450899Z","caller":"traceutil/trace.go:171","msg":"trace[1556390816] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"174.331993ms","start":"2026-04-20T08:13:17.276507Z","end":"2026-04-20T08:13:17.450839Z","steps":["trace[1556390816] 'process raft request' (duration: 174.158569ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.451081Z","caller":"traceutil/trace.go:171","msg":"trace[1413538289] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"174.486495ms","start":"2026-04-20T08:13:17.276562Z","end":"2026-04-20T08:13:17.451049Z","steps":["trace[1413538289] 'process raft request' (duration: 174.135027ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.45119Z","caller":"traceutil/trace.go:171","msg":"trace[368377182] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"174.453254ms","start":"2026-04-20T08:13:17.276657Z","end":"2026-04-20T08:13:17.45111Z","steps":["trace[368377182] 'process raft request' (duration: 174.177318ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.451289Z","caller":"traceutil/trace.go:171","msg":"trace[362897707] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"154.884554ms","start":"2026-04-20T08:13:17.296391Z","end":"2026-04-20T08:13:17.451275Z","steps":["trace[362897707] 'process raft request' (duration: 154.485535ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.451591Z","caller":"traceutil/trace.go:171","msg":"trace[1144023366] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"155.104849ms","start":"2026-04-20T08:13:17.296478Z","end":"2026-04-20T08:13:17.451583Z","steps":["trace[1144023366] 'process raft request' (duration: 154.452374ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.452514Z","caller":"traceutil/trace.go:171","msg":"trace[644125188] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"133.88961ms","start":"2026-04-20T08:13:17.318613Z","end":"2026-04-20T08:13:17.452502Z","steps":["trace[644125188] 'process raft request' (duration: 133.219164ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.451638Z","caller":"traceutil/trace.go:171","msg":"trace[508220579] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"205.867673ms","start":"2026-04-20T08:13:17.245754Z","end":"2026-04-20T08:13:17.451622Z","steps":["trace[508220579] 'process raft request' (duration: 204.84937ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.451862Z","caller":"traceutil/trace.go:171","msg":"trace[913285768] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"181.736486ms","start":"2026-04-20T08:13:17.269009Z","end":"2026-04-20T08:13:17.450746Z","steps":["trace[913285768] 'process raft request' (duration: 181.626463ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:24.238129Z","caller":"traceutil/trace.go:171","msg":"trace[1985990182] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"202.920815ms","start":"2026-04-20T08:13:24.035168Z","end":"2026-04-20T08:13:24.238089Z","steps":["trace[1985990182] 'process raft request' (duration: 202.254609ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:24.855182Z","caller":"traceutil/trace.go:171","msg":"trace[878697655] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"474.311289ms","start":"2026-04-20T08:13:24.380834Z","end":"2026-04-20T08:13:24.855145Z","steps":["trace[878697655] 'read index received' (duration: 473.952121ms)","trace[878697655] 'applied index is now lower than readState.Index' (duration: 357.668µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:24.855325Z","caller":"traceutil/trace.go:171","msg":"trace[132315371] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"551.768842ms","start":"2026-04-20T08:13:24.303499Z","end":"2026-04-20T08:13:24.855267Z","steps":["trace[132315371] 'process raft request' (duration: 551.421724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:24.855508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.658146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tlxpt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T08:13:24.85557Z","caller":"traceutil/trace.go:171","msg":"trace[363234977] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tlxpt; range_end:; response_count:1; response_revision:585; }","duration":"474.77246ms","start":"2026-04-20T08:13:24.380771Z","end":"2026-04-20T08:13:24.855543Z","steps":["trace[363234977] 'agreement among raft nodes before linearized reading' (duration: 474.552945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:24.855617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.431618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T08:13:24.855627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:24.380742Z","time spent":"474.873043ms","remote":"127.0.0.1:57610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-tlxpt\" "} {"level":"info","ts":"2026-04-20T08:13:24.855717Z","caller":"traceutil/trace.go:171","msg":"trace[204003034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"467.598461ms","start":"2026-04-20T08:13:24.388094Z","end":"2026-04-20T08:13:24.855693Z","steps":["trace[204003034] 'agreement among raft nodes before linearized reading' (duration: 467.328675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:24.855777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:24.388069Z","time spent":"467.699074ms","remote":"127.0.0.1:57694","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-04-20T08:13:24.85602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.32933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T08:13:24.856101Z","caller":"traceutil/trace.go:171","msg":"trace[788510226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"389.446192ms","start":"2026-04-20T08:13:24.466631Z","end":"2026-04-20T08:13:24.856077Z","steps":["trace[788510226] 'agreement among raft nodes before linearized reading' (duration: 389.114125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:24.856078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.083646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T08:13:24.856291Z","caller":"traceutil/trace.go:171","msg":"trace[455448383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"398.341172ms","start":"2026-04-20T08:13:24.457926Z","end":"2026-04-20T08:13:24.856267Z","steps":["trace[455448383] 'agreement among raft nodes before linearized reading' (duration: 398.031275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:24.856156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:24.46661Z","time spent":"389.532355ms","remote":"127.0.0.1:57694","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-04-20T08:13:24.856538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:24.457901Z","time spent":"398.438153ms","remote":"127.0.0.1:57694","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-04-20T08:13:24.859332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:24.303481Z","time spent":"551.969266ms","remote":"127.0.0.1:57668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:13:25.006105Z","caller":"traceutil/trace.go:171","msg":"trace[2083891227] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"141.93405ms","start":"2026-04-20T08:13:24.864137Z","end":"2026-04-20T08:13:25.006071Z","steps":["trace[2083891227] 'process raft request' (duration: 126.464986ms)","trace[2083891227] 'compare' (duration: 15.081955ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:25.006662Z","caller":"traceutil/trace.go:171","msg":"trace[637418795] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:607; }","duration":"139.41234ms","start":"2026-04-20T08:13:24.867218Z","end":"2026-04-20T08:13:25.006631Z","steps":["trace[637418795] 'read index received' (duration: 123.540826ms)","trace[637418795] 'applied index is now lower than readState.Index' (duration: 15.870104ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:25.006788Z","caller":"traceutil/trace.go:171","msg":"trace[7565605] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"142.475532ms","start":"2026-04-20T08:13:24.864263Z","end":"2026-04-20T08:13:25.006738Z","steps":["trace[7565605] 'process raft request' (duration: 142.108624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:25.006905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.646756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-20T08:13:25.006967Z","caller":"traceutil/trace.go:171","msg":"trace[208276658] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:589; }","duration":"139.778169ms","start":"2026-04-20T08:13:24.867173Z","end":"2026-04-20T08:13:25.006951Z","steps":["trace[208276658] 'agreement among raft nodes before linearized reading' (duration: 139.597045ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:25.007084Z","caller":"traceutil/trace.go:171","msg":"trace[403104308] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"142.901372ms","start":"2026-04-20T08:13:24.864139Z","end":"2026-04-20T08:13:25.00704Z","steps":["trace[403104308] 'process raft request' (duration: 141.839988ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:25.007368Z","caller":"traceutil/trace.go:171","msg":"trace[996521423] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"130.283645ms","start":"2026-04-20T08:13:24.877076Z","end":"2026-04-20T08:13:25.00736Z","steps":["trace[996521423] 'process raft request' (duration: 129.368623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:26.646238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.911352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:26.646306Z","caller":"traceutil/trace.go:171","msg":"trace[798198443] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:616; }","duration":"103.008064ms","start":"2026-04-20T08:13:26.543286Z","end":"2026-04-20T08:13:26.646294Z","steps":["trace[798198443] 'range keys from in-memory index tree' (duration: 102.858611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:26.646517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.964259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:26.646543Z","caller":"traceutil/trace.go:171","msg":"trace[25950162] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:616; }","duration":"105.015651ms","start":"2026-04-20T08:13:26.54152Z","end":"2026-04-20T08:13:26.646536Z","steps":["trace[25950162] 'range keys from in-memory index tree' (duration: 104.909668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:26.646671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.96764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:26.646694Z","caller":"traceutil/trace.go:171","msg":"trace[1373146951] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:616; }","duration":"105.038051ms","start":"2026-04-20T08:13:26.54165Z","end":"2026-04-20T08:13:26.646688Z","steps":["trace[1373146951] 'count revisions from in-memory index tree' (duration: 104.796116ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:31.484209Z","caller":"traceutil/trace.go:171","msg":"trace[1513147413] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:705; }","duration":"131.902804ms","start":"2026-04-20T08:13:31.352279Z","end":"2026-04-20T08:13:31.484182Z","steps":["trace[1513147413] 'read index received' (duration: 31.699346ms)","trace[1513147413] 'applied index is now lower than readState.Index' (duration: 100.202238ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:31.484237Z","caller":"traceutil/trace.go:171","msg":"trace[988600080] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"155.14706ms","start":"2026-04-20T08:13:31.329038Z","end":"2026-04-20T08:13:31.484185Z","steps":["trace[988600080] 'process raft request' (duration: 153.548743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:31.48449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.17646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:31.484566Z","caller":"traceutil/trace.go:171","msg":"trace[414283897] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:683; }","duration":"132.304712ms","start":"2026-04-20T08:13:31.352247Z","end":"2026-04-20T08:13:31.484552Z","steps":["trace[414283897] 'agreement among raft nodes before linearized reading' (duration: 132.139738ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:31.48441Z","caller":"traceutil/trace.go:171","msg":"trace[381086704] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"152.924507ms","start":"2026-04-20T08:13:31.331463Z","end":"2026-04-20T08:13:31.484387Z","steps":["trace[381086704] 'process raft request' (duration: 152.658051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:31.492562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.234659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:31.492632Z","caller":"traceutil/trace.go:171","msg":"trace[1568512272] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:684; }","duration":"140.339302ms","start":"2026-04-20T08:13:31.352275Z","end":"2026-04-20T08:13:31.492614Z","steps":["trace[1568512272] 'agreement among raft nodes before linearized reading' (duration: 140.199799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:31.492886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.83525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:31.492914Z","caller":"traceutil/trace.go:171","msg":"trace[1976800294] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:684; }","duration":"139.911132ms","start":"2026-04-20T08:13:31.352997Z","end":"2026-04-20T08:13:31.492908Z","steps":["trace[1976800294] 'agreement among raft nodes before linearized reading' (duration: 139.84098ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:31.493083Z","caller":"traceutil/trace.go:171","msg":"trace[136743502] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"103.030103ms","start":"2026-04-20T08:13:31.390015Z","end":"2026-04-20T08:13:31.493045Z","steps":["trace[136743502] 'process raft request' (duration: 102.371908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:31.493308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.953196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-868p2\" ","response":"range_response_count:1 size:3835"} {"level":"info","ts":"2026-04-20T08:13:31.493533Z","caller":"traceutil/trace.go:171","msg":"trace[651632188] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-868p2; range_end:; response_count:1; response_revision:684; }","duration":"104.213572ms","start":"2026-04-20T08:13:31.389256Z","end":"2026-04-20T08:13:31.49347Z","steps":["trace[651632188] 'agreement among raft nodes before linearized reading' (duration: 103.25134ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:31.603748Z","caller":"traceutil/trace.go:171","msg":"trace[1228426343] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"104.058138ms","start":"2026-04-20T08:13:31.499643Z","end":"2026-04-20T08:13:31.603701Z","steps":["trace[1228426343] 'process raft request' (duration: 94.072123ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:36.668722Z","caller":"traceutil/trace.go:171","msg":"trace[1795354478] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"203.181751ms","start":"2026-04-20T08:13:36.465518Z","end":"2026-04-20T08:13:36.6687Z","steps":["trace[1795354478] 'process raft request' (duration: 203.046308ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:38.861334Z","caller":"traceutil/trace.go:171","msg":"trace[197144409] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"531.415774ms","start":"2026-04-20T08:13:38.329896Z","end":"2026-04-20T08:13:38.861311Z","steps":["trace[197144409] 'process raft request' (duration: 531.290371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:38.861721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:38.329871Z","time spent":"531.546186ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:13:40.362451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.157095ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:40.362656Z","caller":"traceutil/trace.go:171","msg":"trace[1635961031] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:734; }","duration":"114.39901ms","start":"2026-04-20T08:13:40.24823Z","end":"2026-04-20T08:13:40.362629Z","steps":["trace[1635961031] 'range keys from in-memory index tree' (duration: 114.122854ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:18.722823Z","caller":"traceutil/trace.go:171","msg":"trace[746126435] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"450.62164ms","start":"2026-04-20T08:14:18.272175Z","end":"2026-04-20T08:14:18.722797Z","steps":["trace[746126435] 'read index received' (duration: 450.481706ms)","trace[746126435] 'applied index is now lower than readState.Index' (duration: 138.524µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:18.722914Z","caller":"traceutil/trace.go:171","msg":"trace[846020055] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"451.913111ms","start":"2026-04-20T08:14:18.270976Z","end":"2026-04-20T08:14:18.722889Z","steps":["trace[846020055] 'process raft request' (duration: 451.681655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:18.723015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.811974ms","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-04-20T08:14:18.723104Z","caller":"traceutil/trace.go:171","msg":"trace[675435056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"450.940187ms","start":"2026-04-20T08:14:18.27215Z","end":"2026-04-20T08:14:18.72309Z","steps":["trace[675435056] 'agreement among raft nodes before linearized reading' (duration: 450.746462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:18.72315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:18.272139Z","time spent":"451.001609ms","remote":"127.0.0.1:57694","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-04-20T08:14:18.723021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:18.270954Z","time spent":"452.012074ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:14:18.839552Z","caller":"traceutil/trace.go:171","msg":"trace[185670967] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"420.112826ms","start":"2026-04-20T08:14:18.419417Z","end":"2026-04-20T08:14:18.83953Z","steps":["trace[185670967] 'process raft request' (duration: 420.060525ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:18.839672Z","caller":"traceutil/trace.go:171","msg":"trace[1334848183] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"565.775507ms","start":"2026-04-20T08:14:18.273849Z","end":"2026-04-20T08:14:18.839624Z","steps":["trace[1334848183] 'process raft request' (duration: 565.476499ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:18.83966Z","caller":"traceutil/trace.go:171","msg":"trace[2062417741] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"565.312626ms","start":"2026-04-20T08:14:18.274333Z","end":"2026-04-20T08:14:18.839645Z","steps":["trace[2062417741] 'process raft request' (duration: 565.11882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:18.840009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:18.273836Z","time spent":"565.90009ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:18.840059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:18.274326Z","time spent":"565.628043ms","remote":"127.0.0.1:57694","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-04-20T08:14:18.839787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:18.419387Z","time spent":"420.325093ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:14:18.840474Z","caller":"traceutil/trace.go:171","msg":"trace[435927411] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"113.686331ms","start":"2026-04-20T08:14:18.726766Z","end":"2026-04-20T08:14:18.840452Z","steps":["trace[435927411] 'process raft request' (duration: 113.585448ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:41.662103Z","caller":"traceutil/trace.go:171","msg":"trace[186441092] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"109.755812ms","start":"2026-04-20T08:14:41.552314Z","end":"2026-04-20T08:14:41.66207Z","steps":["trace[186441092] 'read index received' (duration: 109.527006ms)","trace[186441092] 'applied index is now lower than readState.Index' (duration: 227.306µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:41.662228Z","caller":"traceutil/trace.go:171","msg":"trace[572713443] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"152.004987ms","start":"2026-04-20T08:14:41.510168Z","end":"2026-04-20T08:14:41.662173Z","steps":["trace[572713443] 'process raft request' (duration: 151.663269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:41.662355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.010778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T08:14:41.662402Z","caller":"traceutil/trace.go:171","msg":"trace[522190836] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1043; }","duration":"110.156162ms","start":"2026-04-20T08:14:41.552235Z","end":"2026-04-20T08:14:41.662391Z","steps":["trace[522190836] 'agreement among raft nodes before linearized reading' (duration: 109.956527ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:43.019604Z","caller":"traceutil/trace.go:171","msg":"trace[2077738839] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"100.253516ms","start":"2026-04-20T08:14:42.919325Z","end":"2026-04-20T08:14:43.019578Z","steps":["trace[2077738839] 'process raft request' (duration: 95.138597ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:03.22246Z","caller":"traceutil/trace.go:171","msg":"trace[151053115] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"101.593671ms","start":"2026-04-20T08:15:03.120828Z","end":"2026-04-20T08:15:03.222421Z","steps":["trace[151053115] 'process raft request' (duration: 101.386136ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:05.944606Z","caller":"traceutil/trace.go:171","msg":"trace[1551167212] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"528.906125ms","start":"2026-04-20T08:15:05.415663Z","end":"2026-04-20T08:15:05.94457Z","steps":["trace[1551167212] 'process raft request' (duration: 528.68992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:05.94494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:05.4156Z","time spent":"529.203383ms","remote":"127.0.0.1:57694","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-04-20T08:15:21.488433Z","caller":"traceutil/trace.go:171","msg":"trace[636002488] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"127.956432ms","start":"2026-04-20T08:15:21.360444Z","end":"2026-04-20T08:15:21.488401Z","steps":["trace[636002488] 'process raft request' (duration: 69.647498ms)","trace[636002488] 'compare' (duration: 58.174511ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:23.633034Z","caller":"traceutil/trace.go:171","msg":"trace[1977048935] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"135.994495ms","start":"2026-04-20T08:15:23.497015Z","end":"2026-04-20T08:15:23.63301Z","steps":["trace[1977048935] 'process raft request' (duration: 135.833451ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:24.475242Z","caller":"traceutil/trace.go:171","msg":"trace[106229762] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1317; }","duration":"424.072194ms","start":"2026-04-20T08:15:24.051142Z","end":"2026-04-20T08:15:24.475215Z","steps":["trace[106229762] 'read index received' (duration: 424.010312ms)","trace[106229762] 'applied index is now lower than readState.Index' (duration: 60.452µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:15:24.475405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.247098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:15:24.475446Z","caller":"traceutil/trace.go:171","msg":"trace[2095784291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"424.34407ms","start":"2026-04-20T08:15:24.05109Z","end":"2026-04-20T08:15:24.475434Z","steps":["trace[2095784291] 'agreement among raft nodes before linearized reading' (duration: 424.226537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:24.475484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:24.051065Z","time spent":"424.411192ms","remote":"127.0.0.1:57420","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-04-20T08:15:24.475618Z","caller":"traceutil/trace.go:171","msg":"trace[689605686] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"431.767417ms","start":"2026-04-20T08:15:24.043784Z","end":"2026-04-20T08:15:24.475551Z","steps":["trace[689605686] 'process raft request' (duration: 431.275045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:24.476019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:24.043757Z","time spent":"432.093725ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:15:24.578142Z","caller":"traceutil/trace.go:171","msg":"trace[448080077] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1318; }","duration":"101.125039ms","start":"2026-04-20T08:15:24.476982Z","end":"2026-04-20T08:15:24.578107Z","steps":["trace[448080077] 'read index received' (duration: 74.250354ms)","trace[448080077] 'applied index is now lower than readState.Index' (duration: 26.873065ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:24.578488Z","caller":"traceutil/trace.go:171","msg":"trace[779725270] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"307.517909ms","start":"2026-04-20T08:15:24.270765Z","end":"2026-04-20T08:15:24.578283Z","steps":["trace[779725270] 'process raft request' (duration: 280.444619ms)","trace[779725270] 'compare' (duration: 26.732802ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:15:24.578533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.504918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:15:24.578646Z","caller":"traceutil/trace.go:171","msg":"trace[1284604368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"101.679592ms","start":"2026-04-20T08:15:24.47694Z","end":"2026-04-20T08:15:24.578619Z","steps":["trace[1284604368] 'agreement among raft nodes before linearized reading' (duration: 101.399035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:24.578894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:24.270729Z","time spent":"307.857688ms","remote":"127.0.0.1:57694","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-04-20T08:15:25.535317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":778451663856340968,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T08:15:25.546795Z","caller":"traceutil/trace.go:171","msg":"trace[2142247800] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"527.566322ms","start":"2026-04-20T08:15:25.019196Z","end":"2026-04-20T08:15:25.546762Z","steps":["trace[2142247800] 'process raft request' (duration: 527.378817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.546967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.019172Z","time spent":"527.694025ms","remote":"127.0.0.1:57482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:15:25.749805Z","caller":"traceutil/trace.go:171","msg":"trace[2027888226] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"582.178642ms","start":"2026-04-20T08:15:25.167587Z","end":"2026-04-20T08:15:25.749766Z","steps":["trace[2027888226] 'process raft request' (duration: 581.966377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.750158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.167558Z","time spent":"582.321466ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:15:25.775125Z","caller":"traceutil/trace.go:171","msg":"trace[1455407207] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1321; }","duration":"740.329272ms","start":"2026-04-20T08:15:25.034765Z","end":"2026-04-20T08:15:25.775095Z","steps":["trace[1455407207] 'read index received' (duration: 511.878258ms)","trace[1455407207] 'applied index is now lower than readState.Index' (duration: 228.449684ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:25.775229Z","caller":"traceutil/trace.go:171","msg":"trace[286801990] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"456.761764ms","start":"2026-04-20T08:15:25.318421Z","end":"2026-04-20T08:15:25.775183Z","steps":["trace[286801990] 'process raft request' (duration: 456.530328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.775274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.499326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:15:25.775328Z","caller":"traceutil/trace.go:171","msg":"trace[340760390] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1272; }","duration":"740.623379ms","start":"2026-04-20T08:15:25.034688Z","end":"2026-04-20T08:15:25.775312Z","steps":["trace[340760390] 'agreement among raft nodes before linearized reading' (duration: 740.491636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.775375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.034659Z","time spent":"740.708531ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T08:15:25.775371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.318395Z","time spent":"456.893337ms","remote":"127.0.0.1:57594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5926,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:15:25.828042Z","caller":"traceutil/trace.go:171","msg":"trace[1047445683] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"276.094829ms","start":"2026-04-20T08:15:25.551901Z","end":"2026-04-20T08:15:25.827995Z","steps":["trace[1047445683] 'process raft request' (duration: 256.361674ms)","trace[1047445683] 'compare' (duration: 19.50143ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:15:25.82825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.042345ms","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-04-20T08:15:25.82835Z","caller":"traceutil/trace.go:171","msg":"trace[1883562546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1273; }","duration":"191.200889ms","start":"2026-04-20T08:15:25.637123Z","end":"2026-04-20T08:15:25.828324Z","steps":["trace[1883562546] 'agreement among raft nodes before linearized reading' (duration: 190.902711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.828421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.617081ms","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-04-20T08:15:25.828479Z","caller":"traceutil/trace.go:171","msg":"trace[1983661788] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1273; }","duration":"713.718493ms","start":"2026-04-20T08:15:25.114747Z","end":"2026-04-20T08:15:25.828465Z","steps":["trace[1983661788] 'agreement among raft nodes before linearized reading' (duration: 713.571129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.828513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.114725Z","time spent":"713.779404ms","remote":"127.0.0.1:57694","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-04-20T08:15:25.82883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.119835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:15:25.828887Z","caller":"traceutil/trace.go:171","msg":"trace[1254927766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1273; }","duration":"775.179166ms","start":"2026-04-20T08:15:25.053695Z","end":"2026-04-20T08:15:25.828874Z","steps":["trace[1254927766] 'agreement among raft nodes before linearized reading' (duration: 775.091624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.828921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.053648Z","time spent":"775.264108ms","remote":"127.0.0.1:57420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T08:15:25.828999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.898411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T08:15:25.829057Z","caller":"traceutil/trace.go:171","msg":"trace[1742693110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1273; }","duration":"495.035334ms","start":"2026-04-20T08:15:25.334009Z","end":"2026-04-20T08:15:25.829044Z","steps":["trace[1742693110] 'agreement among raft nodes before linearized reading' (duration: 494.861559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.829092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.333972Z","time spent":"495.111716ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T08:15:25.829235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.150613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T08:15:25.829269Z","caller":"traceutil/trace.go:171","msg":"trace[1909299036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1273; }","duration":"488.210724ms","start":"2026-04-20T08:15:25.341051Z","end":"2026-04-20T08:15:25.829261Z","steps":["trace[1909299036] 'agreement among raft nodes before linearized reading' (duration: 488.112081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:25.829296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:25.341038Z","time spent":"488.252315ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T08:15:26.013521Z","caller":"traceutil/trace.go:171","msg":"trace[788354638] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"135.538651ms","start":"2026-04-20T08:15:25.877946Z","end":"2026-04-20T08:15:26.013485Z","steps":["trace[788354638] 'process raft request' (duration: 120.571686ms)","trace[788354638] 'compare' (duration: 14.803701ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:26.072113Z","caller":"traceutil/trace.go:171","msg":"trace[1802380258] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"167.842774ms","start":"2026-04-20T08:15:25.904241Z","end":"2026-04-20T08:15:26.072084Z","steps":["trace[1802380258] 'process raft request' (duration: 167.618598ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:29.92342Z","caller":"traceutil/trace.go:171","msg":"trace[1623207470] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"420.228248ms","start":"2026-04-20T08:15:29.503166Z","end":"2026-04-20T08:15:29.923394Z","steps":["trace[1623207470] 'process raft request' (duration: 419.999082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:29.923683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:15:29.503144Z","time spent":"420.429492ms","remote":"127.0.0.1:57610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13709,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:15:29.999049Z","caller":"traceutil/trace.go:171","msg":"trace[1426257577] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"234.834025ms","start":"2026-04-20T08:15:29.76419Z","end":"2026-04-20T08:15:29.999024Z","steps":["trace[1426257577] 'process raft request' (duration: 232.303101ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:40.228407Z","caller":"traceutil/trace.go:171","msg":"trace[1514304124] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"110.834003ms","start":"2026-04-20T08:15:40.117528Z","end":"2026-04-20T08:15:40.228362Z","steps":["trace[1514304124] 'process raft request' (duration: 37.06311ms)","trace[1514304124] 'compare' (duration: 73.494516ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:40.228506Z","caller":"traceutil/trace.go:171","msg":"trace[1660450638] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"107.708735ms","start":"2026-04-20T08:15:40.120764Z","end":"2026-04-20T08:15:40.228473Z","steps":["trace[1660450638] 'process raft request' (duration: 107.504459ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:40.228521Z","caller":"traceutil/trace.go:171","msg":"trace[297801227] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"107.648093ms","start":"2026-04-20T08:15:40.120826Z","end":"2026-04-20T08:15:40.228474Z","steps":["trace[297801227] 'process raft request' (duration: 107.518839ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:40.22902Z","caller":"traceutil/trace.go:171","msg":"trace[891581794] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"108.088324ms","start":"2026-04-20T08:15:40.120911Z","end":"2026-04-20T08:15:40.229Z","steps":["trace[891581794] 'process raft request' (duration: 107.475328ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:18:57.916455Z","caller":"traceutil/trace.go:171","msg":"trace[452066877] transaction","detail":"{read_only:false; response_revision:2295; number_of_response:1; }","duration":"117.039665ms","start":"2026-04-20T08:18:57.799382Z","end":"2026-04-20T08:18:57.916421Z","steps":["trace[452066877] 'process raft request' (duration: 97.240305ms)","trace[452066877] 'compare' (duration: 19.698768ms)"],"step_count":2}