{"level":"warn","ts":"2026-06-09T22:15:55.235495Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:15:55.23559Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.168: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.168:2380","--initial-cluster=instance=https://199.19.213.168:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.168:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.168: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-06-09T22:15:55.235674Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:15:55.235681Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.168:2380"]} {"level":"info","ts":"2026-06-09T22:15:55.235699Z","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-06-09T22:15:55.236297Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"]} {"level":"info","ts":"2026-06-09T22:15:55.236367Z","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.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.168: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-06-09T22:15:55.241652Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.101283ms"} {"level":"info","ts":"2026-06-09T22:15:55.258496Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8ae391decac9b376","cluster-id":"d9b32c15a2c66ac"} {"level":"info","ts":"2026-06-09T22:15:55.258574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:15:55.258594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 0"} {"level":"info","ts":"2026-06-09T22:15:55.258606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8ae391decac9b376 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:15:55.258615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 1"} {"level":"info","ts":"2026-06-09T22:15:55.258653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"} {"level":"warn","ts":"2026-06-09T22:15:55.272156Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:15:55.273955Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:15:55.27534Z","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-06-09T22:15:55.277926Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8ae391decac9b376","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:15:55.278344Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8ae391decac9b376","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:15:55.278453Z","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-06-09T22:15:55.278479Z","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-06-09T22:15:55.278489Z","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-06-09T22:15:55.279143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"} {"level":"info","ts":"2026-06-09T22:15:55.27927Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","added-peer-id":"8ae391decac9b376","added-peer-peer-urls":["https://199.19.213.168:2380"]} {"level":"info","ts":"2026-06-09T22:15:55.282822Z","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-06-09T22:15:55.283317Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.168:2380"} {"level":"info","ts":"2026-06-09T22:15:55.283364Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.168:2380"} {"level":"info","ts":"2026-06-09T22:15:55.283724Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8ae391decac9b376","initial-advertise-peer-urls":["https://199.19.213.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:15:55.283825Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:15:56.259555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:15:56.259657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:15:56.259683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgPreVoteResp from 8ae391decac9b376 at term 1"} {"level":"info","ts":"2026-06-09T22:15:56.259707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:15:56.259722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgVoteResp from 8ae391decac9b376 at term 2"} {"level":"info","ts":"2026-06-09T22:15:56.25976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became leader at term 2"} {"level":"info","ts":"2026-06-09T22:15:56.259782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8ae391decac9b376 elected leader 8ae391decac9b376 at term 2"} {"level":"info","ts":"2026-06-09T22:15:56.261277Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:56.262731Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8ae391decac9b376","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.168:2379]}","request-path":"/0/members/8ae391decac9b376/attributes","cluster-id":"d9b32c15a2c66ac","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:15:56.262743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:15:56.262779Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:15:56.263341Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:15:56.263416Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:15:56.264735Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.168:2379"} {"level":"info","ts":"2026-06-09T22:15:56.265345Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:56.265474Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:56.265507Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:56.267074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:16:03.573618Z","caller":"traceutil/trace.go:171","msg":"trace[1673756479] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"161.90544ms","start":"2026-06-09T22:16:03.411695Z","end":"2026-06-09T22:16:03.5736Z","steps":["trace[1673756479] 'process raft request' (duration: 161.80881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:14.333243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.117855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:16:14.333354Z","caller":"traceutil/trace.go:171","msg":"trace[2077794303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:377; }","duration":"124.297725ms","start":"2026-06-09T22:16:14.209036Z","end":"2026-06-09T22:16:14.333334Z","steps":["trace[2077794303] 'range keys from in-memory index tree' (duration: 124.029051ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:21.445032Z","caller":"traceutil/trace.go:171","msg":"trace[2089190256] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"119.470894ms","start":"2026-06-09T22:16:21.325541Z","end":"2026-06-09T22:16:21.445012Z","steps":["trace[2089190256] 'process raft request' (duration: 119.340307ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:34.924333Z","caller":"traceutil/trace.go:171","msg":"trace[401366487] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"633.666996ms","start":"2026-06-09T22:16:34.29063Z","end":"2026-06-09T22:16:34.924297Z","steps":["trace[401366487] 'process raft request' (duration: 633.396584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.925108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.290609Z","time spent":"633.816771ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.988836Z","caller":"traceutil/trace.go:171","msg":"trace[313395709] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"698.077573ms","start":"2026-06-09T22:16:34.29072Z","end":"2026-06-09T22:16:34.988797Z","steps":["trace[313395709] 'process raft request' (duration: 697.854164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.988991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.290688Z","time spent":"698.228689ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.989001Z","caller":"traceutil/trace.go:171","msg":"trace[1604063614] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"688.865619ms","start":"2026-06-09T22:16:34.300109Z","end":"2026-06-09T22:16:34.988975Z","steps":["trace[1604063614] 'process raft request' (duration: 688.619419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.989103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.300083Z","time spent":"688.968424ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.989128Z","caller":"traceutil/trace.go:171","msg":"trace[1104224321] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"697.441576ms","start":"2026-06-09T22:16:34.291673Z","end":"2026-06-09T22:16:34.989114Z","steps":["trace[1104224321] 'process raft request' (duration: 697.009378ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:34.989143Z","caller":"traceutil/trace.go:171","msg":"trace[1041044003] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"685.136804ms","start":"2026-06-09T22:16:34.303977Z","end":"2026-06-09T22:16:34.989114Z","steps":["trace[1041044003] 'process raft request' (duration: 684.823221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.989179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.29154Z","time spent":"697.609524ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.989214Z","caller":"traceutil/trace.go:171","msg":"trace[1943822095] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"686.567184ms","start":"2026-06-09T22:16:34.302639Z","end":"2026-06-09T22:16:34.989206Z","steps":["trace[1943822095] 'process raft request' (duration: 686.124186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.989217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.303968Z","time spent":"685.216598ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:16:34.989244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.302622Z","time spent":"686.606746ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.989258Z","caller":"traceutil/trace.go:171","msg":"trace[211826086] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"678.584632ms","start":"2026-06-09T22:16:34.310665Z","end":"2026-06-09T22:16:34.989249Z","steps":["trace[211826086] 'process raft request' (duration: 678.252318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.989297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.310641Z","time spent":"678.637085ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.991507Z","caller":"traceutil/trace.go:171","msg":"trace[439175729] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:505; }","duration":"444.818814ms","start":"2026-06-09T22:16:34.546671Z","end":"2026-06-09T22:16:34.99149Z","steps":["trace[439175729] 'read index received' (duration: 377.419492ms)","trace[439175729] 'applied index is now lower than readState.Index' (duration: 67.398542ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:16:34.991623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.949179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T22:16:34.991654Z","caller":"traceutil/trace.go:171","msg":"trace[469063689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"445.050174ms","start":"2026-06-09T22:16:34.546598Z","end":"2026-06-09T22:16:34.991648Z","steps":["trace[469063689] 'agreement among raft nodes before linearized reading' (duration: 444.96306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.991679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.546567Z","time spent":"445.105766ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T22:16:34.991911Z","caller":"traceutil/trace.go:171","msg":"trace[824635538] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"656.191391ms","start":"2026-06-09T22:16:34.33571Z","end":"2026-06-09T22:16:34.991901Z","steps":["trace[824635538] 'process raft request' (duration: 655.513913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.991973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.335682Z","time spent":"656.252583ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.992079Z","caller":"traceutil/trace.go:171","msg":"trace[721211657] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"652.020588ms","start":"2026-06-09T22:16:34.340052Z","end":"2026-06-09T22:16:34.992072Z","steps":["trace[721211657] 'process raft request' (duration: 651.239886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.992108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.340027Z","time spent":"652.06588ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.992179Z","caller":"traceutil/trace.go:171","msg":"trace[1430952571] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"646.30698ms","start":"2026-06-09T22:16:34.345866Z","end":"2026-06-09T22:16:34.992173Z","steps":["trace[1430952571] 'process raft request' (duration: 645.470316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.992204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.345843Z","time spent":"646.349052ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.992279Z","caller":"traceutil/trace.go:171","msg":"trace[740981444] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"608.974038ms","start":"2026-06-09T22:16:34.383296Z","end":"2026-06-09T22:16:34.99227Z","steps":["trace[740981444] 'process raft request' (duration: 608.082331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.992314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.38326Z","time spent":"609.035751ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:34.992392Z","caller":"traceutil/trace.go:171","msg":"trace[1093206011] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"497.444641ms","start":"2026-06-09T22:16:34.494942Z","end":"2026-06-09T22:16:34.992386Z","steps":["trace[1093206011] 'process raft request' (duration: 496.495262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:34.992418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:34.494911Z","time spent":"497.494254ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:16:41.513673Z","caller":"traceutil/trace.go:171","msg":"trace[452099835] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"117.320093ms","start":"2026-06-09T22:16:41.396295Z","end":"2026-06-09T22:16:41.513615Z","steps":["trace[452099835] 'process raft request' (duration: 114.11645ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:42.098763Z","caller":"traceutil/trace.go:171","msg":"trace[1285216521] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"106.111663ms","start":"2026-06-09T22:16:41.99262Z","end":"2026-06-09T22:16:42.098731Z","steps":["trace[1285216521] 'process raft request' (duration: 105.843683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:42.660961Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931697852163194894,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T22:16:42.837001Z","caller":"traceutil/trace.go:171","msg":"trace[280663390] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"724.221403ms","start":"2026-06-09T22:16:42.112751Z","end":"2026-06-09T22:16:42.836972Z","steps":["trace[280663390] 'process raft request' (duration: 722.698754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:42.837355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.112707Z","time spent":"724.379978ms","remote":"127.0.0.1:56156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:16:43.752998Z","caller":"traceutil/trace.go:171","msg":"trace[1224630346] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.638222818s","start":"2026-06-09T22:16:42.114722Z","end":"2026-06-09T22:16:43.752945Z","steps":["trace[1224630346] 'process raft request' (duration: 1.604100094s)","trace[1224630346] 'compare' (duration: 32.573346ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:16:43.753154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.114701Z","time spent":"1.638377074s","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:16:43.753157Z","caller":"traceutil/trace.go:171","msg":"trace[1665912105] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"1.5930886s","start":"2026-06-09T22:16:42.160038Z","end":"2026-06-09T22:16:43.753126Z","steps":["trace[1665912105] 'read index received' (duration: 674.799031ms)","trace[1665912105] 'applied index is now lower than readState.Index' (duration: 918.286409ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:16:43.753417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59334914s","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-06-09T22:16:43.753487Z","caller":"traceutil/trace.go:171","msg":"trace[1356814644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"1.593477145s","start":"2026-06-09T22:16:42.159988Z","end":"2026-06-09T22:16:43.753465Z","steps":["trace[1356814644] 'agreement among raft nodes before linearized reading' (duration: 1.593262997s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:43.75354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.159966Z","time spent":"1.593560498s","remote":"127.0.0.1:56338","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-06-09T22:16:43.753703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579113248s","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-06-09T22:16:43.753765Z","caller":"traceutil/trace.go:171","msg":"trace[1415692164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.579258263s","start":"2026-06-09T22:16:42.174487Z","end":"2026-06-09T22:16:43.753745Z","steps":["trace[1415692164] 'agreement among raft nodes before linearized reading' (duration: 1.579012754s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:43.753767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.231412ms","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-06-09T22:16:43.753811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.174448Z","time spent":"1.579350157s","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T22:16:43.75385Z","caller":"traceutil/trace.go:171","msg":"trace[1191118883] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"858.103528ms","start":"2026-06-09T22:16:42.895739Z","end":"2026-06-09T22:16:43.753842Z","steps":["trace[1191118883] 'process raft request' (duration: 857.651511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:43.753897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.895712Z","time spent":"858.16019ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:16:43.754008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54397371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:16:43.753816Z","caller":"traceutil/trace.go:171","msg":"trace[1554747946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"530.320545ms","start":"2026-06-09T22:16:43.223483Z","end":"2026-06-09T22:16:43.753803Z","steps":["trace[1554747946] 'agreement among raft nodes before linearized reading' (duration: 530.093756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:43.754073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.223459Z","time spent":"530.602265ms","remote":"127.0.0.1:56338","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-06-09T22:16:43.754117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.160757ms","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-06-09T22:16:43.75404Z","caller":"traceutil/trace.go:171","msg":"trace[1575916840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"1.544007061s","start":"2026-06-09T22:16:42.210024Z","end":"2026-06-09T22:16:43.754031Z","steps":["trace[1575916840] 'agreement among raft nodes before linearized reading' (duration: 1.543956799s)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:43.754142Z","caller":"traceutil/trace.go:171","msg":"trace[262197895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"675.24095ms","start":"2026-06-09T22:16:43.078894Z","end":"2026-06-09T22:16:43.754135Z","steps":["trace[262197895] 'agreement among raft nodes before linearized reading' (duration: 675.160877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:43.754147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:42.209937Z","time spent":"1.544204269s","remote":"127.0.0.1:56066","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-06-09T22:16:43.754166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.078852Z","time spent":"675.308193ms","remote":"127.0.0.1:56338","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-06-09T22:16:44.177924Z","caller":"traceutil/trace.go:171","msg":"trace[1566619746] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"417.719996ms","start":"2026-06-09T22:16:43.760178Z","end":"2026-06-09T22:16:44.177898Z","steps":["trace[1566619746] 'process raft request' (duration: 403.793007ms)","trace[1566619746] 'compare' (duration: 13.623608ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:16:44.178059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.76015Z","time spent":"417.83964ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:16:44.183829Z","caller":"traceutil/trace.go:171","msg":"trace[1206749553] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"423.149548ms","start":"2026-06-09T22:16:43.760656Z","end":"2026-06-09T22:16:44.183806Z","steps":["trace[1206749553] 'process raft request' (duration: 423.087336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:44.183961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.760645Z","time spent":"423.246612ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:16:44.184017Z","caller":"traceutil/trace.go:171","msg":"trace[114741873] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"423.163258ms","start":"2026-06-09T22:16:43.760815Z","end":"2026-06-09T22:16:44.183978Z","steps":["trace[114741873] 'read index received' (duration: 403.261237ms)","trace[114741873] 'applied index is now lower than readState.Index' (duration: 19.900861ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:16:44.183889Z","caller":"traceutil/trace.go:171","msg":"trace[375490916] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"423.357506ms","start":"2026-06-09T22:16:43.760498Z","end":"2026-06-09T22:16:44.183855Z","steps":["trace[375490916] 'process raft request' (duration: 423.124777ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:44.184042Z","caller":"traceutil/trace.go:171","msg":"trace[1832744166] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"423.370987ms","start":"2026-06-09T22:16:43.760649Z","end":"2026-06-09T22:16:44.18402Z","steps":["trace[1832744166] 'process raft request' (duration: 423.124088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:44.185039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.760611Z","time spent":"424.343883ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:16:44.185146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.335713ms","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-06-09T22:16:44.185211Z","caller":"traceutil/trace.go:171","msg":"trace[113342796] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:605; }","duration":"424.421536ms","start":"2026-06-09T22:16:43.760768Z","end":"2026-06-09T22:16:44.185189Z","steps":["trace[113342796] 'agreement among raft nodes before linearized reading' (duration: 423.337575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:44.185257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.760751Z","time spent":"424.498329ms","remote":"127.0.0.1:56270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-09T22:16:44.185785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.675652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:16:44.185847Z","caller":"traceutil/trace.go:171","msg":"trace[1259633393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"421.771475ms","start":"2026-06-09T22:16:43.764056Z","end":"2026-06-09T22:16:44.185828Z","steps":["trace[1259633393] 'agreement among raft nodes before linearized reading' (duration: 421.658231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:16:44.185906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.764044Z","time spent":"421.850869ms","remote":"127.0.0.1:56066","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-06-09T22:16:44.185844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:16:43.760261Z","time spent":"423.829414ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:16:53.907045Z","caller":"traceutil/trace.go:171","msg":"trace[28587388] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"127.000714ms","start":"2026-06-09T22:16:53.780022Z","end":"2026-06-09T22:16:53.907023Z","steps":["trace[28587388] 'process raft request' (duration: 99.032876ms)","trace[28587388] 'compare' (duration: 27.769331ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:16:54.296855Z","caller":"traceutil/trace.go:171","msg":"trace[594790022] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"110.399892ms","start":"2026-06-09T22:16:54.186432Z","end":"2026-06-09T22:16:54.296832Z","steps":["trace[594790022] 'process raft request' (duration: 110.255837ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:54.411585Z","caller":"traceutil/trace.go:171","msg":"trace[188710729] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"108.756289ms","start":"2026-06-09T22:16:54.302806Z","end":"2026-06-09T22:16:54.411563Z","steps":["trace[188710729] 'process raft request' (duration: 106.576846ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:54.411842Z","caller":"traceutil/trace.go:171","msg":"trace[856414589] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"108.985867ms","start":"2026-06-09T22:16:54.302834Z","end":"2026-06-09T22:16:54.41182Z","steps":["trace[856414589] 'process raft request' (duration: 108.694877ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:54.412002Z","caller":"traceutil/trace.go:171","msg":"trace[1882594641] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"108.980186ms","start":"2026-06-09T22:16:54.302967Z","end":"2026-06-09T22:16:54.411947Z","steps":["trace[1882594641] 'process raft request' (duration: 108.768099ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:16:56.052256Z","caller":"traceutil/trace.go:171","msg":"trace[1106222972] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"128.879684ms","start":"2026-06-09T22:16:55.923345Z","end":"2026-06-09T22:16:56.052225Z","steps":["trace[1106222972] 'process raft request' (duration: 128.618906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:17:01.352817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.908311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:17:01.352905Z","caller":"traceutil/trace.go:171","msg":"trace[238579760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"143.059576ms","start":"2026-06-09T22:17:01.209825Z","end":"2026-06-09T22:17:01.352885Z","steps":["trace[238579760] 'range keys from in-memory index tree' (duration: 142.827029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:17:01.352914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.358888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pzl4l\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-09T22:17:01.352993Z","caller":"traceutil/trace.go:171","msg":"trace[1556039527] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pzl4l; range_end:; response_count:1; response_revision:767; }","duration":"239.502842ms","start":"2026-06-09T22:17:01.113472Z","end":"2026-06-09T22:17:01.352975Z","steps":["trace[1556039527] 'range keys from in-memory index tree' (duration: 239.119101ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:43.410154Z","caller":"traceutil/trace.go:171","msg":"trace[2043956239] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"146.933445ms","start":"2026-06-09T22:17:43.263197Z","end":"2026-06-09T22:17:43.41013Z","steps":["trace[2043956239] 'process raft request' (duration: 146.812333ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:44.388635Z","caller":"traceutil/trace.go:171","msg":"trace[783192338] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"147.840301ms","start":"2026-06-09T22:17:44.240769Z","end":"2026-06-09T22:17:44.388609Z","steps":["trace[783192338] 'process raft request' (duration: 147.695288ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:19:01.297111Z","caller":"traceutil/trace.go:171","msg":"trace[1353847413] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"146.285594ms","start":"2026-06-09T22:19:01.150791Z","end":"2026-06-09T22:19:01.297076Z","steps":["trace[1353847413] 'process raft request' (duration: 145.720926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:01.614875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.080072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:19:01.615034Z","caller":"traceutil/trace.go:171","msg":"trace[1252551114] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1386; }","duration":"123.618208ms","start":"2026-06-09T22:19:01.491393Z","end":"2026-06-09T22:19:01.615011Z","steps":["trace[1252551114] 'read index received' (duration: 39.03µs)","trace[1252551114] 'applied index is now lower than readState.Index' (duration: 123.573378ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:19:01.615115Z","caller":"traceutil/trace.go:171","msg":"trace[1577553022] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"251.644653ms","start":"2026-06-09T22:19:01.363426Z","end":"2026-06-09T22:19:01.615071Z","steps":["trace[1577553022] 'process raft request' (duration: 84.090774ms)","trace[1577553022] 'compare' (duration: 166.840049ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:19:01.615367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.912683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T22:19:01.615496Z","caller":"traceutil/trace.go:171","msg":"trace[1003001662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1331; }","duration":"124.088085ms","start":"2026-06-09T22:19:01.491385Z","end":"2026-06-09T22:19:01.615473Z","steps":["trace[1003001662] 'agreement among raft nodes before linearized reading' (duration: 123.70858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:01.645366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.483739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:19:01.645443Z","caller":"traceutil/trace.go:171","msg":"trace[983724601] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1332; }","duration":"138.60695ms","start":"2026-06-09T22:19:01.506813Z","end":"2026-06-09T22:19:01.64542Z","steps":["trace[983724601] 'agreement among raft nodes before linearized reading' (duration: 138.496729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:01.909703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.062257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:19:01.910076Z","caller":"traceutil/trace.go:171","msg":"trace[7833850] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"264.869218ms","start":"2026-06-09T22:19:01.645179Z","end":"2026-06-09T22:19:01.910048Z","steps":["trace[7833850] 'read index received' (duration: 150.364444ms)","trace[7833850] 'applied index is now lower than readState.Index' (duration: 114.503144ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:19:01.910152Z","caller":"traceutil/trace.go:171","msg":"trace[1442626112] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"289.818568ms","start":"2026-06-09T22:19:01.620289Z","end":"2026-06-09T22:19:01.910107Z","steps":["trace[1442626112] 'process raft request' (duration: 175.238623ms)","trace[1442626112] 'compare' (duration: 113.837424ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:19:01.910422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.571327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:19:01.910563Z","caller":"traceutil/trace.go:171","msg":"trace[1470560551] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1333; }","duration":"273.914662ms","start":"2026-06-09T22:19:01.636614Z","end":"2026-06-09T22:19:01.910528Z","steps":["trace[1470560551] 'agreement among raft nodes before linearized reading' (duration: 273.538017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:13.246736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.604448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:1076"} {"level":"info","ts":"2026-06-09T22:19:13.246835Z","caller":"traceutil/trace.go:171","msg":"trace[1575450418] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1372; }","duration":"156.703509ms","start":"2026-06-09T22:19:13.090108Z","end":"2026-06-09T22:19:13.246811Z","steps":["trace[1575450418] 'range keys from in-memory index tree' (duration: 156.514477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:13.246713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.614096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:19:13.246955Z","caller":"traceutil/trace.go:171","msg":"trace[1792150161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1372; }","duration":"195.93861ms","start":"2026-06-09T22:19:13.050995Z","end":"2026-06-09T22:19:13.246933Z","steps":["trace[1792150161] 'range keys from in-memory index tree' (duration: 195.467833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:13.246601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.915707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation\" ","response":"range_response_count:1 size:541"} {"level":"info","ts":"2026-06-09T22:19:13.247506Z","caller":"traceutil/trace.go:171","msg":"trace[1772773930] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation; range_end:; response_count:1; response_revision:1372; }","duration":"158.80892ms","start":"2026-06-09T22:19:13.08857Z","end":"2026-06-09T22:19:13.247379Z","steps":["trace[1772773930] 'range keys from in-memory index tree' (duration: 157.753235ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:19:13.615753Z","caller":"traceutil/trace.go:171","msg":"trace[573525588] linearizableReadLoop","detail":"{readStateIndex:1432; appliedIndex:1431; }","duration":"255.273818ms","start":"2026-06-09T22:19:13.360449Z","end":"2026-06-09T22:19:13.615723Z","steps":["trace[573525588] 'read index received' (duration: 252.58461ms)","trace[573525588] 'applied index is now lower than readState.Index' (duration: 2.688308ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:19:13.615915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.899691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation\" ","response":"range_response_count:1 size:541"} {"level":"warn","ts":"2026-06-09T22:19:13.615917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.942896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:1076"} {"level":"info","ts":"2026-06-09T22:19:13.615949Z","caller":"traceutil/trace.go:171","msg":"trace[614365157] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation; range_end:; response_count:1; response_revision:1374; }","duration":"284.987292ms","start":"2026-06-09T22:19:13.330949Z","end":"2026-06-09T22:19:13.615936Z","steps":["trace[614365157] 'agreement among raft nodes before linearized reading' (duration: 284.902581ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:19:13.615904Z","caller":"traceutil/trace.go:171","msg":"trace[88126545] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"281.822367ms","start":"2026-06-09T22:19:13.334044Z","end":"2026-06-09T22:19:13.615866Z","steps":["trace[88126545] 'process raft request' (duration: 278.979296ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:19:13.616015Z","caller":"traceutil/trace.go:171","msg":"trace[1447276119] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1374; }","duration":"250.973346ms","start":"2026-06-09T22:19:13.364964Z","end":"2026-06-09T22:19:13.615938Z","steps":["trace[1447276119] 'agreement among raft nodes before linearized reading' (duration: 250.917915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:13.616119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.366796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T22:19:13.616227Z","caller":"traceutil/trace.go:171","msg":"trace[1559105084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1374; }","duration":"224.525359ms","start":"2026-06-09T22:19:13.391677Z","end":"2026-06-09T22:19:13.616202Z","steps":["trace[1559105084] 'agreement among raft nodes before linearized reading' (duration: 224.236905ms)"],"step_count":1}