{"level":"warn","ts":"2026-04-02T06:04:23.709228Z","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-02T06:04:23.70933Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.65: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.65:2380","--initial-cluster=instance=https://199.19.213.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.65: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-02T06:04:23.709402Z","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-02T06:04:23.709413Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-04-02T06:04:23.709431Z","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-02T06:04:23.710049Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"]} {"level":"info","ts":"2026-04-02T06:04:23.710117Z","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.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.65: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-02T06:04:23.714912Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.598418ms"} {"level":"info","ts":"2026-04-02T06:04:23.723002Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a071a454a8148542","cluster-id":"aa233e43aeaf7fe5"} {"level":"info","ts":"2026-04-02T06:04:23.723082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T06:04:23.723102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 0"} {"level":"info","ts":"2026-04-02T06:04:23.72311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a071a454a8148542 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T06:04:23.723119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 1"} {"level":"info","ts":"2026-04-02T06:04:23.723168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"warn","ts":"2026-04-02T06:04:23.734279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T06:04:23.739645Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T06:04:23.74084Z","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-02T06:04:23.742866Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a071a454a8148542","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T06:04:23.743023Z","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-02T06:04:23.743111Z","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-02T06:04:23.743235Z","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-02T06:04:23.743461Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a071a454a8148542","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T06:04:23.744942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"info","ts":"2026-04-02T06:04:23.745224Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","added-peer-id":"a071a454a8148542","added-peer-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-04-02T06:04:23.748243Z","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-02T06:04:23.748509Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a071a454a8148542","initial-advertise-peer-urls":["https://199.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T06:04:23.748564Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T06:04:23.748722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-04-02T06:04:23.748747Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-04-02T06:04:24.324333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T06:04:24.324422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T06:04:24.324454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgPreVoteResp from a071a454a8148542 at term 1"} {"level":"info","ts":"2026-04-02T06:04:24.324475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became candidate at term 2"} {"level":"info","ts":"2026-04-02T06:04:24.324486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgVoteResp from a071a454a8148542 at term 2"} {"level":"info","ts":"2026-04-02T06:04:24.324506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became leader at term 2"} {"level":"info","ts":"2026-04-02T06:04:24.324519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a071a454a8148542 elected leader a071a454a8148542 at term 2"} {"level":"info","ts":"2026-04-02T06:04:24.326326Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a071a454a8148542","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.65:2379]}","request-path":"/0/members/a071a454a8148542/attributes","cluster-id":"aa233e43aeaf7fe5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T06:04:24.32659Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:04:24.327311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:04:24.327713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T06:04:24.327861Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:04:24.328094Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:04:24.32817Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T06:04:24.330312Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T06:04:24.330652Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T06:04:24.330721Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T06:04:24.332949Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.65:2379"} {"level":"warn","ts":"2026-04-02T06:04:28.447207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392129445s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-02T06:04:28.447421Z","caller":"traceutil/trace.go:171","msg":"trace[1548805344] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"1.700496698s","start":"2026-04-02T06:04:26.746892Z","end":"2026-04-02T06:04:28.447389Z","steps":["trace[1548805344] 'process raft request' (duration: 307.647529ms)","trace[1548805344] 'compare' (duration: 1.391995083s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:04:28.447522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:04:26.746865Z","time spent":"1.7006233s","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":563,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T06:04:28.447544Z","caller":"traceutil/trace.go:171","msg":"trace[1284288533] linearizableReadLoop","detail":"{readStateIndex:102; appliedIndex:100; }","duration":"776.224435ms","start":"2026-04-02T06:04:27.6713Z","end":"2026-04-02T06:04:28.447524Z","steps":["trace[1284288533] 'read index received' (duration: 34.58µs)","trace[1284288533] 'applied index is now lower than readState.Index' (duration: 776.188915ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:04:28.447725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.367717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T06:04:28.447588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:04:26.891302Z","time spent":"1.556278152s","remote":"127.0.0.1:53284","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T06:04:28.44778Z","caller":"traceutil/trace.go:171","msg":"trace[794561459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:97; }","duration":"776.51667ms","start":"2026-04-02T06:04:27.671249Z","end":"2026-04-02T06:04:28.447765Z","steps":["trace[794561459] 'agreement among raft nodes before linearized reading' (duration: 776.360287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:04:28.447834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:04:27.671226Z","time spent":"776.589242ms","remote":"127.0.0.1:53216","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-02T06:04:28.447913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.229255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-02T06:04:28.447998Z","caller":"traceutil/trace.go:171","msg":"trace[1874191845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:97; }","duration":"731.348577ms","start":"2026-04-02T06:04:27.716628Z","end":"2026-04-02T06:04:28.447977Z","steps":["trace[1874191845] 'agreement among raft nodes before linearized reading' (duration: 731.128173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:04:28.448044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:04:27.716614Z","time spent":"731.421578ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:04:28.44845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.950349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-02T06:04:28.448512Z","caller":"traceutil/trace.go:171","msg":"trace[967670568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:97; }","duration":"732.035931ms","start":"2026-04-02T06:04:27.716465Z","end":"2026-04-02T06:04:28.448501Z","steps":["trace[967670568] 'agreement among raft nodes before linearized reading' (duration: 731.205595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:04:28.448545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:04:27.716446Z","time spent":"732.087221ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T06:04:28.676768Z","caller":"traceutil/trace.go:171","msg":"trace[1611242830] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"223.526862ms","start":"2026-04-02T06:04:28.453203Z","end":"2026-04-02T06:04:28.67673Z","steps":["trace[1611242830] 'process raft request' (duration: 223.184765ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:28.677235Z","caller":"traceutil/trace.go:171","msg":"trace[299231465] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"223.466861ms","start":"2026-04-02T06:04:28.453439Z","end":"2026-04-02T06:04:28.676905Z","steps":["trace[299231465] 'process raft request' (duration: 223.117625ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:28.677848Z","caller":"traceutil/trace.go:171","msg":"trace[982327093] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"178.311318ms","start":"2026-04-02T06:04:28.49951Z","end":"2026-04-02T06:04:28.677821Z","steps":["trace[982327093] 'process raft request' (duration: 178.269047ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:28.677979Z","caller":"traceutil/trace.go:171","msg":"trace[794293360] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"179.107324ms","start":"2026-04-02T06:04:28.498854Z","end":"2026-04-02T06:04:28.677961Z","steps":["trace[794293360] 'process raft request' (duration: 178.831358ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:31.281027Z","caller":"traceutil/trace.go:171","msg":"trace[1848135966] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"259.931689ms","start":"2026-04-02T06:04:31.021066Z","end":"2026-04-02T06:04:31.280998Z","steps":["trace[1848135966] 'process raft request' (duration: 257.868929ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.425313Z","caller":"traceutil/trace.go:171","msg":"trace[199533000] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"189.338638ms","start":"2026-04-02T06:04:55.235949Z","end":"2026-04-02T06:04:55.425288Z","steps":["trace[199533000] 'process raft request' (duration: 189.199535ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.509926Z","caller":"traceutil/trace.go:171","msg":"trace[1677418603] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"269.830536ms","start":"2026-04-02T06:04:55.240054Z","end":"2026-04-02T06:04:55.509885Z","steps":["trace[1677418603] 'process raft request' (duration: 269.634882ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.51027Z","caller":"traceutil/trace.go:171","msg":"trace[620970783] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"219.387333ms","start":"2026-04-02T06:04:55.290858Z","end":"2026-04-02T06:04:55.510246Z","steps":["trace[620970783] 'process raft request' (duration: 219.057706ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.5103Z","caller":"traceutil/trace.go:171","msg":"trace[860039599] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"207.400263ms","start":"2026-04-02T06:04:55.30288Z","end":"2026-04-02T06:04:55.51028Z","steps":["trace[860039599] 'process raft request' (duration: 207.123417ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510299Z","caller":"traceutil/trace.go:171","msg":"trace[638849912] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"210.052194ms","start":"2026-04-02T06:04:55.30021Z","end":"2026-04-02T06:04:55.510262Z","steps":["trace[638849912] 'process raft request' (duration: 209.761928ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510383Z","caller":"traceutil/trace.go:171","msg":"trace[1320183245] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"199.498003ms","start":"2026-04-02T06:04:55.310879Z","end":"2026-04-02T06:04:55.510377Z","steps":["trace[1320183245] 'process raft request' (duration: 199.206978ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.51041Z","caller":"traceutil/trace.go:171","msg":"trace[1633735110] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"265.334801ms","start":"2026-04-02T06:04:55.245066Z","end":"2026-04-02T06:04:55.510401Z","steps":["trace[1633735110] 'process raft request' (duration: 264.700488ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510428Z","caller":"traceutil/trace.go:171","msg":"trace[1432327100] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"230.365333ms","start":"2026-04-02T06:04:55.280057Z","end":"2026-04-02T06:04:55.510422Z","steps":["trace[1432327100] 'process raft request' (duration: 229.803692ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510463Z","caller":"traceutil/trace.go:171","msg":"trace[1280874506] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"217.056137ms","start":"2026-04-02T06:04:55.293392Z","end":"2026-04-02T06:04:55.510448Z","steps":["trace[1280874506] 'process raft request' (duration: 216.551337ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510473Z","caller":"traceutil/trace.go:171","msg":"trace[479047614] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"249.214573ms","start":"2026-04-02T06:04:55.261253Z","end":"2026-04-02T06:04:55.510468Z","steps":["trace[479047614] 'process raft request' (duration: 248.542109ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:55.510492Z","caller":"traceutil/trace.go:171","msg":"trace[327896310] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"230.373453ms","start":"2026-04-02T06:04:55.28011Z","end":"2026-04-02T06:04:55.510484Z","steps":["trace[327896310] 'process raft request' (duration: 229.780871ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:04:56.816302Z","caller":"traceutil/trace.go:171","msg":"trace[1074228485] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"157.054691ms","start":"2026-04-02T06:04:56.659215Z","end":"2026-04-02T06:04:56.816269Z","steps":["trace[1074228485] 'process raft request' (duration: 94.092938ms)","trace[1074228485] 'compare' (duration: 62.79166ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:01.556963Z","caller":"traceutil/trace.go:171","msg":"trace[105144469] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"397.943534ms","start":"2026-04-02T06:05:01.158995Z","end":"2026-04-02T06:05:01.556939Z","steps":["trace[105144469] 'process raft request' (duration: 397.782161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:01.55746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:01.158978Z","time spent":"398.064216ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:05:01.714659Z","caller":"traceutil/trace.go:171","msg":"trace[1903952221] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"465.101888ms","start":"2026-04-02T06:05:01.249524Z","end":"2026-04-02T06:05:01.714626Z","steps":["trace[1903952221] 'process raft request' (duration: 448.570152ms)","trace[1903952221] 'compare' (duration: 16.172799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:05:01.715019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:01.249489Z","time spent":"465.24292ms","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:05:01.724864Z","caller":"traceutil/trace.go:171","msg":"trace[1601223203] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"111.163523ms","start":"2026-04-02T06:05:01.613668Z","end":"2026-04-02T06:05:01.724831Z","steps":["trace[1601223203] 'process raft request' (duration: 110.95679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.498143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.960603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-02T06:05:02.498232Z","caller":"traceutil/trace.go:171","msg":"trace[182893946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"244.098805ms","start":"2026-04-02T06:05:02.254114Z","end":"2026-04-02T06:05:02.498213Z","steps":["trace[182893946] 'range keys from in-memory index tree' (duration: 243.779178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.498267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.982644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:02.498362Z","caller":"traceutil/trace.go:171","msg":"trace[1431261614] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:609; }","duration":"679.119757ms","start":"2026-04-02T06:05:01.819218Z","end":"2026-04-02T06:05:02.498338Z","steps":["trace[1431261614] 'range keys from in-memory index tree' (duration: 678.822831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.498409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:01.819201Z","time spent":"679.198848ms","remote":"127.0.0.1:53528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-02T06:05:02.498461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.900579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:02.498501Z","caller":"traceutil/trace.go:171","msg":"trace[754953418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"358.964571ms","start":"2026-04-02T06:05:02.139527Z","end":"2026-04-02T06:05:02.498492Z","steps":["trace[754953418] 'range keys from in-memory index tree' (duration: 358.797017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.498567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:02.139515Z","time spent":"359.043702ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:05:02.498696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.440219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xg65b\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-02T06:05:02.499102Z","caller":"traceutil/trace.go:171","msg":"trace[12004398] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xg65b; range_end:; response_count:1; response_revision:609; }","duration":"616.883767ms","start":"2026-04-02T06:05:01.882194Z","end":"2026-04-02T06:05:02.499078Z","steps":["trace[12004398] 'range keys from in-memory index tree' (duration: 616.024681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:02.499232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:01.882181Z","time spent":"617.03572ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-xg65b\" "} {"level":"info","ts":"2026-04-02T06:05:02.703127Z","caller":"traceutil/trace.go:171","msg":"trace[2101485581] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"200.300268ms","start":"2026-04-02T06:05:02.502813Z","end":"2026-04-02T06:05:02.703113Z","steps":["trace[2101485581] 'process raft request' (duration: 200.202496ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:02.74289Z","caller":"traceutil/trace.go:171","msg":"trace[1051399864] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"225.710903ms","start":"2026-04-02T06:05:02.517153Z","end":"2026-04-02T06:05:02.742864Z","steps":["trace[1051399864] 'process raft request' (duration: 225.442108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.062018Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602410308655722520,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:05:04.429176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568115796s","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-02T06:05:04.429189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.565804512s","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-02T06:05:04.42924Z","caller":"traceutil/trace.go:171","msg":"trace[1154849675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"1.568197327s","start":"2026-04-02T06:05:02.861027Z","end":"2026-04-02T06:05:04.429225Z","steps":["trace[1154849675] 'range keys from in-memory index tree' (duration: 1.567929522s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.429284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:02.86095Z","time spent":"1.568328449s","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T06:05:04.429325Z","caller":"traceutil/trace.go:171","msg":"trace[197827331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"1.565910963s","start":"2026-04-02T06:05:02.863334Z","end":"2026-04-02T06:05:04.429245Z","steps":["trace[197827331] 'range keys from in-memory index tree' (duration: 1.565659339s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.429377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:02.863323Z","time spent":"1.566045467s","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:05:04.429614Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.510002554s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:05:04.431805Z","caller":"traceutil/trace.go:171","msg":"trace[1896548106] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"870.699488ms","start":"2026-04-02T06:05:03.561085Z","end":"2026-04-02T06:05:04.431785Z","steps":["trace[1896548106] 'read index received' (duration: 868.679499ms)","trace[1896548106] 'applied index is now lower than readState.Index' (duration: 2.017839ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:04.431835Z","caller":"traceutil/trace.go:171","msg":"trace[607238432] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.51345949s","start":"2026-04-02T06:05:02.918337Z","end":"2026-04-02T06:05:04.431796Z","steps":["trace[607238432] 'process raft request' (duration: 1.511637385s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.432076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:02.918313Z","time spent":"1.513603154s","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:05:04.443847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.765499ms","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-02T06:05:04.443879Z","caller":"traceutil/trace.go:171","msg":"trace[1267141968] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"882.83714ms","start":"2026-04-02T06:05:03.561033Z","end":"2026-04-02T06:05:04.44387Z","steps":["trace[1267141968] 'agreement among raft nodes before linearized reading' (duration: 870.859511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.4439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:03.561013Z","time spent":"882.881961ms","remote":"127.0.0.1:53458","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-02T06:05:04.444003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.785835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:05:04.444019Z","caller":"traceutil/trace.go:171","msg":"trace[554332957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"303.840246ms","start":"2026-04-02T06:05:04.140174Z","end":"2026-04-02T06:05:04.444014Z","steps":["trace[554332957] 'agreement among raft nodes before linearized reading' (duration: 303.792485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:04.444036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:04.140151Z","time spent":"303.882148ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:05:06.461226Z","caller":"traceutil/trace.go:171","msg":"trace[38070975] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"289.444672ms","start":"2026-04-02T06:05:06.171759Z","end":"2026-04-02T06:05:06.461204Z","steps":["trace[38070975] 'process raft request' (duration: 289.284029ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:06.477042Z","caller":"traceutil/trace.go:171","msg":"trace[746409500] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"103.950046ms","start":"2026-04-02T06:05:06.373066Z","end":"2026-04-02T06:05:06.477016Z","steps":["trace[746409500] 'process raft request' (duration: 103.595499ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:20.120415Z","caller":"traceutil/trace.go:171","msg":"trace[646117191] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"145.8764ms","start":"2026-04-02T06:05:19.974516Z","end":"2026-04-02T06:05:20.120393Z","steps":["trace[646117191] 'read index received' (duration: 145.719177ms)","trace[646117191] 'applied index is now lower than readState.Index' (duration: 156.083µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:20.120622Z","caller":"traceutil/trace.go:171","msg":"trace[760815328] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"270.964207ms","start":"2026-04-02T06:05:19.849631Z","end":"2026-04-02T06:05:20.120596Z","steps":["trace[760815328] 'process raft request' (duration: 270.630501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:20.120781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.129244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sv8k4\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-02T06:05:20.120828Z","caller":"traceutil/trace.go:171","msg":"trace[1373857965] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sv8k4; range_end:; response_count:1; response_revision:780; }","duration":"146.354808ms","start":"2026-04-02T06:05:19.974461Z","end":"2026-04-02T06:05:20.120816Z","steps":["trace[1373857965] 'agreement among raft nodes before linearized reading' (duration: 146.026382ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:21.017814Z","caller":"traceutil/trace.go:171","msg":"trace[1288534852] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"466.896784ms","start":"2026-04-02T06:05:20.550874Z","end":"2026-04-02T06:05:21.017771Z","steps":["trace[1288534852] 'read index received' (duration: 466.72788ms)","trace[1288534852] 'applied index is now lower than readState.Index' (duration: 168.494µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:21.017904Z","caller":"traceutil/trace.go:171","msg":"trace[1654713543] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"889.555589ms","start":"2026-04-02T06:05:20.128341Z","end":"2026-04-02T06:05:21.017896Z","steps":["trace[1654713543] 'process raft request' (duration: 889.306243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:21.018179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.334556ms","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-02T06:05:21.018239Z","caller":"traceutil/trace.go:171","msg":"trace[1885758316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"465.482578ms","start":"2026-04-02T06:05:20.552738Z","end":"2026-04-02T06:05:21.018221Z","steps":["trace[1885758316] 'agreement among raft nodes before linearized reading' (duration: 465.289484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:21.018265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:20.55272Z","time spent":"465.539839ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T06:05:21.018392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.452524ms","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-02T06:05:21.018481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.702163ms","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-02T06:05:21.018483Z","caller":"traceutil/trace.go:171","msg":"trace[1568974762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"467.630748ms","start":"2026-04-02T06:05:20.550839Z","end":"2026-04-02T06:05:21.01847Z","steps":["trace[1568974762] 'agreement among raft nodes before linearized reading' (duration: 467.435535ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:05:21.018549Z","caller":"traceutil/trace.go:171","msg":"trace[785546796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"464.806825ms","start":"2026-04-02T06:05:20.553726Z","end":"2026-04-02T06:05:21.018533Z","steps":["trace[785546796] 'agreement among raft nodes before linearized reading' (duration: 464.584601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:21.018577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:20.55082Z","time spent":"467.73489ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:05:21.018586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:20.553716Z","time spent":"464.864346ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:05:21.018508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.006227ms","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-02T06:05:21.018764Z","caller":"traceutil/trace.go:171","msg":"trace[556609234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"231.288271ms","start":"2026-04-02T06:05:20.787464Z","end":"2026-04-02T06:05:21.018753Z","steps":["trace[556609234] 'agreement among raft nodes before linearized reading' (duration: 230.66972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:21.018842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:20.128319Z","time spent":"889.60305ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:05:56.524113Z","caller":"traceutil/trace.go:171","msg":"trace[701144197] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1036; }","duration":"226.036163ms","start":"2026-04-02T06:05:56.298056Z","end":"2026-04-02T06:05:56.524092Z","steps":["trace[701144197] 'read index received' (duration: 225.83498ms)","trace[701144197] 'applied index is now lower than readState.Index' (duration: 200.403µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:05:56.524178Z","caller":"traceutil/trace.go:171","msg":"trace[2095018213] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"400.798553ms","start":"2026-04-02T06:05:56.123349Z","end":"2026-04-02T06:05:56.524147Z","steps":["trace[2095018213] 'process raft request' (duration: 400.60602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:56.524317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.243078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T06:05:56.524349Z","caller":"traceutil/trace.go:171","msg":"trace[705670922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1001; }","duration":"226.328379ms","start":"2026-04-02T06:05:56.298011Z","end":"2026-04-02T06:05:56.524339Z","steps":["trace[705670922] 'agreement among raft nodes before linearized reading' (duration: 226.200666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:05:56.524386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:05:56.123321Z","time spent":"400.942516ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:06:17.398017Z","caller":"traceutil/trace.go:171","msg":"trace[1333453794] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"117.140978ms","start":"2026-04-02T06:06:17.280855Z","end":"2026-04-02T06:06:17.397996Z","steps":["trace[1333453794] 'read index received' (duration: 117.002416ms)","trace[1333453794] 'applied index is now lower than readState.Index' (duration: 137.602µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:17.398163Z","caller":"traceutil/trace.go:171","msg":"trace[2061528999] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"117.71722ms","start":"2026-04-02T06:06:17.280408Z","end":"2026-04-02T06:06:17.398125Z","steps":["trace[2061528999] 'process raft request' (duration: 117.457365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:17.398381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.310764ms","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-02T06:06:17.398464Z","caller":"traceutil/trace.go:171","msg":"trace[862400177] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1069; }","duration":"108.417705ms","start":"2026-04-02T06:06:17.290028Z","end":"2026-04-02T06:06:17.398446Z","steps":["trace[862400177] 'agreement among raft nodes before linearized reading' (duration: 108.222102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:17.398556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.682799ms","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-02T06:06:17.398594Z","caller":"traceutil/trace.go:171","msg":"trace[1917476160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1069; }","duration":"117.75431ms","start":"2026-04-02T06:06:17.280829Z","end":"2026-04-02T06:06:17.398584Z","steps":["trace[1917476160] 'agreement among raft nodes before linearized reading' (duration: 117.613207ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:18.223436Z","caller":"traceutil/trace.go:171","msg":"trace[1110457338] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"183.22066ms","start":"2026-04-02T06:06:18.04018Z","end":"2026-04-02T06:06:18.223401Z","steps":["trace[1110457338] 'process raft request' (duration: 183.048017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.070202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.491462ms","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-02T06:06:19.07034Z","caller":"traceutil/trace.go:171","msg":"trace[493669206] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1073; }","duration":"356.650155ms","start":"2026-04-02T06:06:18.713668Z","end":"2026-04-02T06:06:19.070318Z","steps":["trace[493669206] 'range keys from in-memory index tree' (duration: 356.460392ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:19.078028Z","caller":"traceutil/trace.go:171","msg":"trace[269139480] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"458.733301ms","start":"2026-04-02T06:06:18.619277Z","end":"2026-04-02T06:06:19.078011Z","steps":["trace[269139480] 'read index received' (duration: 458.511837ms)","trace[269139480] 'applied index is now lower than readState.Index' (duration: 220.554µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:19.07812Z","caller":"traceutil/trace.go:171","msg":"trace[1725696707] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"487.699615ms","start":"2026-04-02T06:06:18.590411Z","end":"2026-04-02T06:06:19.07811Z","steps":["trace[1725696707] 'process raft request' (duration: 487.46359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.078211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:18.590385Z","time spent":"487.760485ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:19.078463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.1698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T06:06:19.078539Z","caller":"traceutil/trace.go:171","msg":"trace[1275360972] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1074; }","duration":"459.253681ms","start":"2026-04-02T06:06:18.619265Z","end":"2026-04-02T06:06:19.078519Z","steps":["trace[1275360972] 'agreement among raft nodes before linearized reading' (duration: 459.086797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.078574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:18.619208Z","time spent":"459.358713ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:19.508562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.382785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:06:19.50877Z","caller":"traceutil/trace.go:171","msg":"trace[941840469] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1114; }","duration":"368.228472ms","start":"2026-04-02T06:06:19.140521Z","end":"2026-04-02T06:06:19.508749Z","steps":["trace[941840469] 'read index received' (duration: 169.454781ms)","trace[941840469] 'applied index is now lower than readState.Index' (duration: 198.771871ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:19.508793Z","caller":"traceutil/trace.go:171","msg":"trace[1545457094] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"426.918194ms","start":"2026-04-02T06:06:19.081838Z","end":"2026-04-02T06:06:19.508757Z","steps":["trace[1545457094] 'process raft request' (duration: 228.244164ms)","trace[1545457094] 'compare' (duration: 198.270953ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:06:19.508896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.367455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:19.508948Z","caller":"traceutil/trace.go:171","msg":"trace[1988175504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"368.453816ms","start":"2026-04-02T06:06:19.140479Z","end":"2026-04-02T06:06:19.508933Z","steps":["trace[1988175504] 'agreement among raft nodes before linearized reading' (duration: 368.375535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.508968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:19.081818Z","time spent":"427.051686ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:19.50923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.544856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T06:06:19.509276Z","caller":"traceutil/trace.go:171","msg":"trace[792789550] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:1075; }","duration":"231.637177ms","start":"2026-04-02T06:06:19.277626Z","end":"2026-04-02T06:06:19.509263Z","steps":["trace[792789550] 'agreement among raft nodes before linearized reading' (duration: 231.498175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.509513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.66527ms","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-02T06:06:19.509545Z","caller":"traceutil/trace.go:171","msg":"trace[108350485] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1075; }","duration":"107.739482ms","start":"2026-04-02T06:06:19.401796Z","end":"2026-04-02T06:06:19.509536Z","steps":["trace[108350485] 'agreement among raft nodes before linearized reading' (duration: 107.62629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.508989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:19.140462Z","time spent":"368.516328ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:06:19.69277Z","caller":"traceutil/trace.go:171","msg":"trace[1503429175] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"181.920645ms","start":"2026-04-02T06:06:19.510805Z","end":"2026-04-02T06:06:19.692725Z","steps":["trace[1503429175] 'read index received' (duration: 99.802944ms)","trace[1503429175] 'applied index is now lower than readState.Index' (duration: 82.114791ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:19.692847Z","caller":"traceutil/trace.go:171","msg":"trace[1528426673] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"177.282258ms","start":"2026-04-02T06:06:19.515545Z","end":"2026-04-02T06:06:19.692827Z","steps":["trace[1528426673] 'process raft request' (duration: 177.231797ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:19.692952Z","caller":"traceutil/trace.go:171","msg":"trace[1376972573] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"179.689653ms","start":"2026-04-02T06:06:19.513236Z","end":"2026-04-02T06:06:19.692926Z","steps":["trace[1376972573] 'process raft request' (duration: 179.295955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:19.693012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.172769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:19.693293Z","caller":"traceutil/trace.go:171","msg":"trace[621851970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1079; }","duration":"182.306312ms","start":"2026-04-02T06:06:19.51078Z","end":"2026-04-02T06:06:19.693086Z","steps":["trace[621851970] 'agreement among raft nodes before linearized reading' (duration: 182.103388ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:19.693478Z","caller":"traceutil/trace.go:171","msg":"trace[369096807] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"179.272095ms","start":"2026-04-02T06:06:19.514175Z","end":"2026-04-02T06:06:19.693447Z","steps":["trace[369096807] 'process raft request' (duration: 178.496ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:19.693562Z","caller":"traceutil/trace.go:171","msg":"trace[1624020007] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"179.271195ms","start":"2026-04-02T06:06:19.514252Z","end":"2026-04-02T06:06:19.693524Z","steps":["trace[1624020007] 'process raft request' (duration: 178.48002ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:19.834006Z","caller":"traceutil/trace.go:171","msg":"trace[1141178284] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"140.205952ms","start":"2026-04-02T06:06:19.693776Z","end":"2026-04-02T06:06:19.833982Z","steps":["trace[1141178284] 'process raft request' (duration: 128.863089ms)","trace[1141178284] 'compare' (duration: 11.20758ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:21.184534Z","caller":"traceutil/trace.go:171","msg":"trace[1753293681] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"100.435375ms","start":"2026-04-02T06:06:21.084081Z","end":"2026-04-02T06:06:21.184517Z","steps":["trace[1753293681] 'process raft request' (duration: 100.184251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:21.889724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.020716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T06:06:21.889807Z","caller":"traceutil/trace.go:171","msg":"trace[571122602] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1081; }","duration":"427.148977ms","start":"2026-04-02T06:06:21.462639Z","end":"2026-04-02T06:06:21.889788Z","steps":["trace[571122602] 'count revisions from in-memory index tree' (duration: 426.958274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:21.889897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:21.462625Z","time spent":"427.215849ms","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:06:21.890146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.122747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-02T06:06:21.890383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.362369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:06:21.890924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.466182ms","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-02T06:06:21.890988Z","caller":"traceutil/trace.go:171","msg":"trace[751352041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1081; }","duration":"192.549554ms","start":"2026-04-02T06:06:21.698421Z","end":"2026-04-02T06:06:21.89097Z","steps":["trace[751352041] 'range keys from in-memory index tree' (duration: 191.732179ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:21.891055Z","caller":"traceutil/trace.go:171","msg":"trace[674363385] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1081; }","duration":"578.032371ms","start":"2026-04-02T06:06:21.312926Z","end":"2026-04-02T06:06:21.890959Z","steps":["trace[674363385] 'count revisions from in-memory index tree' (duration: 577.261316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:21.891152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:21.312908Z","time spent":"578.222584ms","remote":"127.0.0.1:53344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:06:21.890537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.962693ms","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-02T06:06:21.890669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.592826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T06:06:21.891478Z","caller":"traceutil/trace.go:171","msg":"trace[359045006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"192.945322ms","start":"2026-04-02T06:06:21.698513Z","end":"2026-04-02T06:06:21.891458Z","steps":["trace[359045006] 'range keys from in-memory index tree' (duration: 191.714659ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:21.891636Z","caller":"traceutil/trace.go:171","msg":"trace[2048379398] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1081; }","duration":"379.601355ms","start":"2026-04-02T06:06:21.512007Z","end":"2026-04-02T06:06:21.891608Z","steps":["trace[2048379398] 'range keys from in-memory index tree' (duration: 378.165089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:21.891739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:21.511994Z","time spent":"379.726867ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T06:06:21.890204Z","caller":"traceutil/trace.go:171","msg":"trace[1924463116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1081; }","duration":"192.2457ms","start":"2026-04-02T06:06:21.697943Z","end":"2026-04-02T06:06:21.890189Z","steps":["trace[1924463116] 'range keys from in-memory index tree' (duration: 191.773659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:21.890907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.77765ms","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-02T06:06:21.892211Z","caller":"traceutil/trace.go:171","msg":"trace[1013476087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1081; }","duration":"192.110146ms","start":"2026-04-02T06:06:21.700081Z","end":"2026-04-02T06:06:21.892191Z","steps":["trace[1013476087] 'range keys from in-memory index tree' (duration: 190.291572ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:22.121131Z","caller":"traceutil/trace.go:171","msg":"trace[1722146408] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"224.775391ms","start":"2026-04-02T06:06:21.896333Z","end":"2026-04-02T06:06:22.121109Z","steps":["trace[1722146408] 'process raft request' (duration: 224.613538ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:22.139486Z","caller":"traceutil/trace.go:171","msg":"trace[428138328] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"241.637767ms","start":"2026-04-02T06:06:21.897822Z","end":"2026-04-02T06:06:22.13946Z","steps":["trace[428138328] 'process raft request' (duration: 241.518045ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:22.139498Z","caller":"traceutil/trace.go:171","msg":"trace[1928070013] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"242.86017ms","start":"2026-04-02T06:06:21.896606Z","end":"2026-04-02T06:06:22.139466Z","steps":["trace[1928070013] 'process raft request' (duration: 242.559415ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:22.13972Z","caller":"traceutil/trace.go:171","msg":"trace[1012978368] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"241.122576ms","start":"2026-04-02T06:06:21.89854Z","end":"2026-04-02T06:06:22.139663Z","steps":["trace[1012978368] 'process raft request' (duration: 240.881642ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:22.139777Z","caller":"traceutil/trace.go:171","msg":"trace[283610049] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"242.594053ms","start":"2026-04-02T06:06:21.897171Z","end":"2026-04-02T06:06:22.139765Z","steps":["trace[283610049] 'process raft request' (duration: 242.126225ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:34.154873Z","caller":"traceutil/trace.go:171","msg":"trace[663911531] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"922.044708ms","start":"2026-04-02T06:06:33.232806Z","end":"2026-04-02T06:06:34.15485Z","steps":["trace[663911531] 'process raft request' (duration: 921.892916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.155022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:33.232791Z","time spent":"922.15322ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:34.706599Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602410308655723798,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:06:34.867795Z","caller":"traceutil/trace.go:171","msg":"trace[292241775] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1216; }","duration":"662.166293ms","start":"2026-04-02T06:06:34.205608Z","end":"2026-04-02T06:06:34.867774Z","steps":["trace[292241775] 'read index received' (duration: 657.313982ms)","trace[292241775] 'applied index is now lower than readState.Index' (duration: 4.851281ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:34.868031Z","caller":"traceutil/trace.go:171","msg":"trace[439819318] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"664.603319ms","start":"2026-04-02T06:06:34.203369Z","end":"2026-04-02T06:06:34.867972Z","steps":["trace[439819318] 'process raft request' (duration: 659.568115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.868093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.465818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:06:34.868085Z","caller":"traceutil/trace.go:171","msg":"trace[1912827405] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"528.443465ms","start":"2026-04-02T06:06:34.339609Z","end":"2026-04-02T06:06:34.868053Z","steps":["trace[1912827405] 'process raft request' (duration: 528.013966ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:34.868139Z","caller":"traceutil/trace.go:171","msg":"trace[82205626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1173; }","duration":"662.55334ms","start":"2026-04-02T06:06:34.205573Z","end":"2026-04-02T06:06:34.868127Z","steps":["trace[82205626] 'agreement among raft nodes before linearized reading' (duration: 662.373547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.868128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.427948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T06:06:34.868145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.618623ms","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-02T06:06:34.86818Z","caller":"traceutil/trace.go:171","msg":"trace[2012868071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1173; }","duration":"662.494969ms","start":"2026-04-02T06:06:34.205676Z","end":"2026-04-02T06:06:34.868171Z","steps":["trace[2012868071] 'agreement among raft nodes before linearized reading' (duration: 662.333966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.868178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.205559Z","time spent":"662.608321ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:34.868169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.203354Z","time spent":"664.738862ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:06:34.868198Z","caller":"traceutil/trace.go:171","msg":"trace[2064639942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1173; }","duration":"661.675814ms","start":"2026-04-02T06:06:34.206512Z","end":"2026-04-02T06:06:34.868188Z","steps":["trace[2064639942] 'agreement among raft nodes before linearized reading' (duration: 661.553922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.868204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.205673Z","time spent":"662.526369ms","remote":"127.0.0.1:53458","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-02T06:06:34.868227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.206457Z","time spent":"661.763416ms","remote":"127.0.0.1:53458","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-02T06:06:34.868232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.339591Z","time spent":"528.559557ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:34.868265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.827387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T06:06:34.868324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.953408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:34.868333Z","caller":"traceutil/trace.go:171","msg":"trace[525742853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1173; }","duration":"661.905339ms","start":"2026-04-02T06:06:34.206411Z","end":"2026-04-02T06:06:34.868316Z","steps":["trace[525742853] 'agreement among raft nodes before linearized reading' (duration: 661.690175ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:34.86835Z","caller":"traceutil/trace.go:171","msg":"trace[447546939] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1173; }","duration":"215.011158ms","start":"2026-04-02T06:06:34.653331Z","end":"2026-04-02T06:06:34.868342Z","steps":["trace[447546939] 'agreement among raft nodes before linearized reading' (duration: 214.967827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:34.868375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:34.206398Z","time spent":"661.968619ms","remote":"127.0.0.1:53458","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-04-02T06:06:50.571308Z","caller":"traceutil/trace.go:171","msg":"trace[1208359560] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"278.663667ms","start":"2026-04-02T06:06:50.292612Z","end":"2026-04-02T06:06:50.571275Z","steps":["trace[1208359560] 'process raft request' (duration: 278.403812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.341108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.324882ms","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-02T06:06:51.341174Z","caller":"traceutil/trace.go:171","msg":"trace[1136464891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"414.435284ms","start":"2026-04-02T06:06:50.926719Z","end":"2026-04-02T06:06:51.341154Z","steps":["trace[1136464891] 'range keys from in-memory index tree' (duration: 414.141979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.341206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:50.926699Z","time spent":"414.499565ms","remote":"127.0.0.1:53458","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-02T06:06:51.341309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.713749ms","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-02T06:06:51.341394Z","caller":"traceutil/trace.go:171","msg":"trace[1956376569] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1245; }","duration":"361.83543ms","start":"2026-04-02T06:06:50.979525Z","end":"2026-04-02T06:06:51.34136Z","steps":["trace[1956376569] 'range keys from in-memory index tree' (duration: 361.524575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.341438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:50.9795Z","time spent":"361.928133ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:51.341428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.346101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-02T06:06:51.341459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.061395ms","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-02T06:06:51.341499Z","caller":"traceutil/trace.go:171","msg":"trace[530406272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"369.452273ms","start":"2026-04-02T06:06:50.972029Z","end":"2026-04-02T06:06:51.341481Z","steps":["trace[530406272] 'range keys from in-memory index tree' (duration: 369.166458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.34155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:50.971983Z","time spent":"369.558376ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T06:06:51.341524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.041225ms","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-02T06:06:51.341626Z","caller":"traceutil/trace.go:171","msg":"trace[1511480001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"362.172107ms","start":"2026-04-02T06:06:50.979429Z","end":"2026-04-02T06:06:51.341601Z","steps":["trace[1511480001] 'range keys from in-memory index tree' (duration: 361.845901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.341671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:50.979422Z","time spent":"362.239639ms","remote":"127.0.0.1:53458","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-04-02T06:06:51.341561Z","caller":"traceutil/trace.go:171","msg":"trace[88762425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"369.211558ms","start":"2026-04-02T06:06:50.972321Z","end":"2026-04-02T06:06:51.341532Z","steps":["trace[88762425] 'range keys from in-memory index tree' (duration: 368.853812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:51.341721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:50.972301Z","time spent":"369.407833ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T06:06:52.948864Z","caller":"traceutil/trace.go:171","msg":"trace[1349226636] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"372.386778ms","start":"2026-04-02T06:06:52.576453Z","end":"2026-04-02T06:06:52.948839Z","steps":["trace[1349226636] 'process raft request' (duration: 372.213485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:52.949062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:52.576425Z","time spent":"372.52646ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:53.645798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.351517ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T06:06:53.645895Z","caller":"traceutil/trace.go:171","msg":"trace[1807724975] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"580.428725ms","start":"2026-04-02T06:06:53.065451Z","end":"2026-04-02T06:06:53.64588Z","steps":["trace[1807724975] 'read index received' (duration: 412.880785ms)","trace[1807724975] 'applied index is now lower than readState.Index' (duration: 167.54678ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:53.645976Z","caller":"traceutil/trace.go:171","msg":"trace[2070856638] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"688.609558ms","start":"2026-04-02T06:06:52.957356Z","end":"2026-04-02T06:06:53.645965Z","steps":["trace[2070856638] 'process raft request' (duration: 521.027937ms)","trace[2070856638] 'compare' (duration: 167.222224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:06:53.646029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:52.957157Z","time spent":"688.848702ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T06:06:53.646272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.818792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:53.646308Z","caller":"traceutil/trace.go:171","msg":"trace[1580672386] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1253; }","duration":"580.884585ms","start":"2026-04-02T06:06:53.065414Z","end":"2026-04-02T06:06:53.646298Z","steps":["trace[1580672386] 'agreement among raft nodes before linearized reading' (duration: 580.800552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:53.646344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:53.065398Z","time spent":"580.937525ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T06:06:53.646529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.944386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T06:06:53.646603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.782219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T06:06:53.646616Z","caller":"traceutil/trace.go:171","msg":"trace[2059062088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1253; }","duration":"504.078629ms","start":"2026-04-02T06:06:53.142519Z","end":"2026-04-02T06:06:53.646597Z","steps":["trace[2059062088] 'agreement among raft nodes before linearized reading' (duration: 503.929306ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.646642Z","caller":"traceutil/trace.go:171","msg":"trace[928520379] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1253; }","duration":"218.84782ms","start":"2026-04-02T06:06:53.427786Z","end":"2026-04-02T06:06:53.646634Z","steps":["trace[928520379] 'agreement among raft nodes before linearized reading' (duration: 218.729628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:53.646663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:53.142502Z","time spent":"504.15368ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T06:06:53.646674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.462452ms","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-02T06:06:53.646731Z","caller":"traceutil/trace.go:171","msg":"trace[1651369322] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1253; }","duration":"218.581204ms","start":"2026-04-02T06:06:53.428138Z","end":"2026-04-02T06:06:53.64672Z","steps":["trace[1651369322] 'agreement among raft nodes before linearized reading' (duration: 218.428722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:53.646852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.14001ms","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-02T06:06:53.64687Z","caller":"traceutil/trace.go:171","msg":"trace[1973145269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1253; }","duration":"284.15975ms","start":"2026-04-02T06:06:53.362706Z","end":"2026-04-02T06:06:53.646866Z","steps":["trace[1973145269] 'agreement among raft nodes before linearized reading' (duration: 284.117819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:53.646933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.185376ms","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-02T06:06:53.646947Z","caller":"traceutil/trace.go:171","msg":"trace[1297370014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1253; }","duration":"219.220376ms","start":"2026-04-02T06:06:53.427724Z","end":"2026-04-02T06:06:53.646944Z","steps":["trace[1297370014] 'agreement among raft nodes before linearized reading' (duration: 219.180476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:53.647105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.241506ms","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-02T06:06:53.647232Z","caller":"traceutil/trace.go:171","msg":"trace[1492581377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1253; }","duration":"219.347269ms","start":"2026-04-02T06:06:53.427807Z","end":"2026-04-02T06:06:53.647154Z","steps":["trace[1492581377] 'agreement among raft nodes before linearized reading' (duration: 218.795079ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.811874Z","caller":"traceutil/trace.go:171","msg":"trace[1454056479] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"161.255963ms","start":"2026-04-02T06:06:53.650583Z","end":"2026-04-02T06:06:53.811839Z","steps":["trace[1454056479] 'process raft request' (duration: 152.394107ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.811976Z","caller":"traceutil/trace.go:171","msg":"trace[234615520] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"155.061348ms","start":"2026-04-02T06:06:53.656891Z","end":"2026-04-02T06:06:53.811952Z","steps":["trace[234615520] 'process raft request' (duration: 155.008447ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.812168Z","caller":"traceutil/trace.go:171","msg":"trace[2067810790] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"159.153094ms","start":"2026-04-02T06:06:53.653003Z","end":"2026-04-02T06:06:53.812156Z","steps":["trace[2067810790] 'process raft request' (duration: 158.787978ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.812243Z","caller":"traceutil/trace.go:171","msg":"trace[710394532] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"156.26698ms","start":"2026-04-02T06:06:53.655966Z","end":"2026-04-02T06:06:53.812233Z","steps":["trace[710394532] 'process raft request' (duration: 155.863672ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.812368Z","caller":"traceutil/trace.go:171","msg":"trace[1207433833] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"155.815571ms","start":"2026-04-02T06:06:53.656543Z","end":"2026-04-02T06:06:53.812359Z","steps":["trace[1207433833] 'process raft request' (duration: 155.318602ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:53.812694Z","caller":"traceutil/trace.go:171","msg":"trace[1540145169] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"161.581639ms","start":"2026-04-02T06:06:53.651095Z","end":"2026-04-02T06:06:53.812677Z","steps":["trace[1540145169] 'process raft request' (duration: 160.619741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:54.881823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.251677ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-04-02T06:06:55.64042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602410308655723992,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T06:06:55.676552Z","caller":"traceutil/trace.go:171","msg":"trace[586802152] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"536.907643ms","start":"2026-04-02T06:06:55.139628Z","end":"2026-04-02T06:06:55.676536Z","steps":["trace[586802152] 'read index received' (duration: 536.76153ms)","trace[586802152] 'applied index is now lower than readState.Index' (duration: 145.293µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:06:55.676832Z","caller":"traceutil/trace.go:171","msg":"trace[2043921436] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"589.210819ms","start":"2026-04-02T06:06:55.087611Z","end":"2026-04-02T06:06:55.676822Z","steps":["trace[2043921436] 'process raft request' (duration: 588.819931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:55.676984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:55.087585Z","time spent":"589.276731ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:55.677149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.491734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:06:55.677224Z","caller":"traceutil/trace.go:171","msg":"trace[1342961819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1265; }","duration":"537.612036ms","start":"2026-04-02T06:06:55.139586Z","end":"2026-04-02T06:06:55.677198Z","steps":["trace[1342961819] 'agreement among raft nodes before linearized reading' (duration: 537.475624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:55.677291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:55.139565Z","time spent":"537.712998ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:06:56.145972Z","caller":"traceutil/trace.go:171","msg":"trace[1206478845] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"325.516193ms","start":"2026-04-02T06:06:55.820427Z","end":"2026-04-02T06:06:56.145943Z","steps":["trace[1206478845] 'process raft request' (duration: 235.586153ms)","trace[1206478845] 'compare' (duration: 89.743427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:06:56.146293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:55.820413Z","time spent":"325.762848ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:06:56.146304Z","caller":"traceutil/trace.go:171","msg":"trace[1149474004] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"325.771937ms","start":"2026-04-02T06:06:55.820507Z","end":"2026-04-02T06:06:56.146279Z","steps":["trace[1149474004] 'process raft request' (duration: 325.396501ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:06:56.146365Z","caller":"traceutil/trace.go:171","msg":"trace[2017893924] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"325.798348ms","start":"2026-04-02T06:06:55.820548Z","end":"2026-04-02T06:06:56.146347Z","steps":["trace[2017893924] 'process raft request' (duration: 325.620144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:06:56.14644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:55.820501Z","time spent":"325.861209ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:06:56.146468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:06:55.820543Z","time spent":"325.871699ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:06:59.023145Z","caller":"traceutil/trace.go:171","msg":"trace[414297811] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"115.650651ms","start":"2026-04-02T06:06:58.907474Z","end":"2026-04-02T06:06:59.023125Z","steps":["trace[414297811] 'process raft request' (duration: 115.527019ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:03.550124Z","caller":"traceutil/trace.go:171","msg":"trace[1312738955] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1377; }","duration":"239.341072ms","start":"2026-04-02T06:07:03.310757Z","end":"2026-04-02T06:07:03.550098Z","steps":["trace[1312738955] 'read index received' (duration: 239.20751ms)","trace[1312738955] 'applied index is now lower than readState.Index' (duration: 132.312µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:03.550185Z","caller":"traceutil/trace.go:171","msg":"trace[1459434386] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"506.83229ms","start":"2026-04-02T06:07:03.043319Z","end":"2026-04-02T06:07:03.550151Z","steps":["trace[1459434386] 'process raft request' (duration: 506.615056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:03.550389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.767786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-04-02T06:07:03.550379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.043282Z","time spent":"506.980393ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T06:07:03.550435Z","caller":"traceutil/trace.go:171","msg":"trace[467041124] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1327; }","duration":"128.879178ms","start":"2026-04-02T06:07:03.421543Z","end":"2026-04-02T06:07:03.550423Z","steps":["trace[467041124] 'agreement among raft nodes before linearized reading' (duration: 128.701235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:03.550519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.622087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:03.550661Z","caller":"traceutil/trace.go:171","msg":"trace[1983986665] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1327; }","duration":"239.892972ms","start":"2026-04-02T06:07:03.310736Z","end":"2026-04-02T06:07:03.550629Z","steps":["trace[1983986665] 'agreement among raft nodes before linearized reading' (duration: 239.563096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.245493Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602410308655724113,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T06:07:04.714218Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.159171629s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T06:07:04.730101Z","caller":"traceutil/trace.go:171","msg":"trace[1569004561] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"985.175209ms","start":"2026-04-02T06:07:03.744905Z","end":"2026-04-02T06:07:04.730081Z","steps":["trace[1569004561] 'read index received' (duration: 969.632489ms)","trace[1569004561] 'applied index is now lower than readState.Index' (duration: 15.54153ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T06:07:04.730184Z","caller":"traceutil/trace.go:171","msg":"trace[996021325] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"1.17520998s","start":"2026-04-02T06:07:03.554942Z","end":"2026-04-02T06:07:04.730152Z","steps":["trace[996021325] 'process raft request' (duration: 1.159579598s)","trace[996021325] 'compare' (duration: 14.837377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T06:07:04.730318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.554917Z","time spent":"1.175328412s","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T06:07:04.730394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.482274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-02T06:07:04.730426Z","caller":"traceutil/trace.go:171","msg":"trace[2074326438] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1328; }","duration":"985.573516ms","start":"2026-04-02T06:07:03.744844Z","end":"2026-04-02T06:07:04.730418Z","steps":["trace[2074326438] 'agreement among raft nodes before linearized reading' (duration: 985.396453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.730452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.744818Z","time spent":"985.628018ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-02T06:07:04.736496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.471517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:04.736542Z","caller":"traceutil/trace.go:171","msg":"trace[895342023] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1329; }","duration":"922.563059ms","start":"2026-04-02T06:07:03.813969Z","end":"2026-04-02T06:07:04.736532Z","steps":["trace[895342023] 'agreement among raft nodes before linearized reading' (duration: 922.429227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.736572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.813948Z","time spent":"922.61501ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T06:07:04.736704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.409166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"warn","ts":"2026-04-02T06:07:04.736731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.154316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-02T06:07:04.736761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.529247ms","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-02T06:07:04.736777Z","caller":"traceutil/trace.go:171","msg":"trace[1521746023] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1330; }","duration":"561.220887ms","start":"2026-04-02T06:07:04.175544Z","end":"2026-04-02T06:07:04.736765Z","steps":["trace[1521746023] 'agreement among raft nodes before linearized reading' (duration: 561.078944ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:04.736795Z","caller":"traceutil/trace.go:171","msg":"trace[927498236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1330; }","duration":"877.606159ms","start":"2026-04-02T06:07:03.859181Z","end":"2026-04-02T06:07:04.736787Z","steps":["trace[927498236] 'agreement among raft nodes before linearized reading' (duration: 877.525486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.736817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.85915Z","time spent":"877.6626ms","remote":"127.0.0.1:53458","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-02T06:07:04.73682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.175535Z","time spent":"561.277618ms","remote":"127.0.0.1:53458","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-02T06:07:04.736823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.732499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:04.736866Z","caller":"traceutil/trace.go:171","msg":"trace[1139484365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"597.816731ms","start":"2026-04-02T06:07:04.13904Z","end":"2026-04-02T06:07:04.736857Z","steps":["trace[1139484365] 'agreement among raft nodes before linearized reading' (duration: 597.75972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.736898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.120664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T06:07:04.736906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.139018Z","time spent":"597.881382ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T06:07:04.736772Z","caller":"traceutil/trace.go:171","msg":"trace[906233901] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1330; }","duration":"709.529208ms","start":"2026-04-02T06:07:04.027226Z","end":"2026-04-02T06:07:04.736755Z","steps":["trace[906233901] 'agreement among raft nodes before linearized reading' (duration: 709.330124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.736973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.027202Z","time spent":"709.762583ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T06:07:04.737037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.079919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T06:07:04.737066Z","caller":"traceutil/trace.go:171","msg":"trace[1131317517] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1330; }","duration":"192.154891ms","start":"2026-04-02T06:07:04.544903Z","end":"2026-04-02T06:07:04.737058Z","steps":["trace[1131317517] 'agreement among raft nodes before linearized reading' (duration: 192.11646ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T06:07:04.736916Z","caller":"traceutil/trace.go:171","msg":"trace[1565792270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1330; }","duration":"913.164634ms","start":"2026-04-02T06:07:03.823746Z","end":"2026-04-02T06:07:04.736911Z","steps":["trace[1565792270] 'agreement among raft nodes before linearized reading' (duration: 913.116023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.737112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:03.823726Z","time spent":"913.376658ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T06:07:04.737214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.364195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T06:07:04.737252Z","caller":"traceutil/trace.go:171","msg":"trace[351685802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1330; }","duration":"557.434977ms","start":"2026-04-02T06:07:04.179807Z","end":"2026-04-02T06:07:04.737242Z","steps":["trace[351685802] 'agreement among raft nodes before linearized reading' (duration: 557.226573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.737285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.179789Z","time spent":"557.489258ms","remote":"127.0.0.1:53458","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-02T06:07:04.737384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.883764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T06:07:04.737425Z","caller":"traceutil/trace.go:171","msg":"trace[367042879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1329; }","duration":"557.963737ms","start":"2026-04-02T06:07:04.179451Z","end":"2026-04-02T06:07:04.737415Z","steps":["trace[367042879] 'agreement among raft nodes before linearized reading' (duration: 557.028389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T06:07:04.737458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T06:07:04.179429Z","time spent":"558.022928ms","remote":"127.0.0.1:53458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}