{"level":"warn","ts":"2026-04-21T02:20:01.207014Z","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-21T02:20:01.207105Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.9: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.9:2380","--initial-cluster=instance=https://199.19.213.9:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.9:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.9: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-21T02:20:01.207241Z","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-21T02:20:01.207261Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-04-21T02:20:01.207325Z","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-21T02:20:01.208067Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"]} {"level":"info","ts":"2026-04-21T02:20:01.208205Z","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.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.9: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-21T02:20:01.214922Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.428541ms"} {"level":"info","ts":"2026-04-21T02:20:01.227515Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3a0c9d65f167b31b","cluster-id":"86e523b598166645"} {"level":"info","ts":"2026-04-21T02:20:01.227648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T02:20:01.227679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 0"} {"level":"info","ts":"2026-04-21T02:20:01.227697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3a0c9d65f167b31b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T02:20:01.227719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 1"} {"level":"info","ts":"2026-04-21T02:20:01.227762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"warn","ts":"2026-04-21T02:20:01.237233Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T02:20:01.241445Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T02:20:01.242667Z","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-21T02:20:01.244504Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3a0c9d65f167b31b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T02:20:01.244869Z","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-21T02:20:01.244917Z","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-21T02:20:01.244925Z","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-21T02:20:01.244954Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3a0c9d65f167b31b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T02:20:01.248354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"info","ts":"2026-04-21T02:20:01.248524Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","added-peer-id":"3a0c9d65f167b31b","added-peer-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-04-21T02:20:01.250658Z","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-21T02:20:01.250828Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-04-21T02:20:01.250868Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-04-21T02:20:01.251079Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3a0c9d65f167b31b","initial-advertise-peer-urls":["https://199.19.213.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T02:20:01.251128Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T02:20:02.128906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T02:20:02.129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T02:20:02.129039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgPreVoteResp from 3a0c9d65f167b31b at term 1"} {"level":"info","ts":"2026-04-21T02:20:02.129067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became candidate at term 2"} {"level":"info","ts":"2026-04-21T02:20:02.129092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgVoteResp from 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-04-21T02:20:02.129123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became leader at term 2"} {"level":"info","ts":"2026-04-21T02:20:02.129145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3a0c9d65f167b31b elected leader 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-04-21T02:20:02.130003Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3a0c9d65f167b31b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.9:2379]}","request-path":"/0/members/3a0c9d65f167b31b/attributes","cluster-id":"86e523b598166645","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T02:20:02.130065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T02:20:02.130233Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T02:20:02.130395Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T02:20:02.130464Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T02:20:02.130089Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T02:20:02.131283Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T02:20:02.131454Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T02:20:02.131499Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T02:20:02.132899Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.9:2379"} {"level":"info","ts":"2026-04-21T02:20:02.1342Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T02:20:30.252563Z","caller":"traceutil/trace.go:171","msg":"trace[252199328] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"574.5746ms","start":"2026-04-21T02:20:29.677963Z","end":"2026-04-21T02:20:30.252538Z","steps":["trace[252199328] 'process raft request' (duration: 574.395246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:30.252674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.083034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:20:30.252725Z","caller":"traceutil/trace.go:171","msg":"trace[2090196187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:430; }","duration":"359.178137ms","start":"2026-04-21T02:20:29.893538Z","end":"2026-04-21T02:20:30.252717Z","steps":["trace[2090196187] 'agreement among raft nodes before linearized reading' (duration: 359.065854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:30.252752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:29.893503Z","time spent":"359.241318ms","remote":"127.0.0.1:53666","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-21T02:20:30.252545Z","caller":"traceutil/trace.go:171","msg":"trace[193068889] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"358.941081ms","start":"2026-04-21T02:20:29.893576Z","end":"2026-04-21T02:20:30.252517Z","steps":["trace[193068889] 'read index received' (duration: 358.763567ms)","trace[193068889] 'applied index is now lower than readState.Index' (duration: 176.724µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:30.253099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:29.677942Z","time spent":"574.681923ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:20:40.648979Z","caller":"traceutil/trace.go:171","msg":"trace[229140061] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"218.337491ms","start":"2026-04-21T02:20:40.430592Z","end":"2026-04-21T02:20:40.64893Z","steps":["trace[229140061] 'process raft request' (duration: 203.86558ms)","trace[229140061] 'compare' (duration: 13.56378ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:20:40.649121Z","caller":"traceutil/trace.go:171","msg":"trace[1281099563] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"130.165981ms","start":"2026-04-21T02:20:40.518923Z","end":"2026-04-21T02:20:40.649089Z","steps":["trace[1281099563] 'process raft request' (duration: 129.893905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.404433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.911195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:20:41.404784Z","caller":"traceutil/trace.go:171","msg":"trace[1606767219] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"468.255985ms","start":"2026-04-21T02:20:40.936497Z","end":"2026-04-21T02:20:41.404753Z","steps":["trace[1606767219] 'read index received' (duration: 248.598673ms)","trace[1606767219] 'applied index is now lower than readState.Index' (duration: 219.653842ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:20:41.404776Z","caller":"traceutil/trace.go:171","msg":"trace[1539771917] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"469.507044ms","start":"2026-04-21T02:20:40.935234Z","end":"2026-04-21T02:20:41.404741Z","steps":["trace[1539771917] 'process raft request' (duration: 249.991016ms)","trace[1539771917] 'compare' (duration: 218.665058ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:20:41.40495Z","caller":"traceutil/trace.go:171","msg":"trace[1836494859] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"419.496818ms","start":"2026-04-21T02:20:40.985402Z","end":"2026-04-21T02:20:41.404899Z","steps":["trace[1836494859] 'process raft request' (duration: 419.16474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:40.985382Z","time spent":"420.429079ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T02:20:41.405112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.176714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T02:20:41.405915Z","caller":"traceutil/trace.go:171","msg":"trace[1023237510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"469.008632ms","start":"2026-04-21T02:20:40.936896Z","end":"2026-04-21T02:20:41.405905Z","steps":["trace[1023237510] 'agreement among raft nodes before linearized reading' (duration: 468.160442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:40.93688Z","time spent":"469.053003ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T02:20:41.405142Z","caller":"traceutil/trace.go:171","msg":"trace[81088473] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"419.640491ms","start":"2026-04-21T02:20:40.985493Z","end":"2026-04-21T02:20:41.405133Z","steps":["trace[81088473] 'process raft request' (duration: 419.177391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.406075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:40.985488Z","time spent":"420.565493ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:41.405173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.667035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-21T02:20:41.406173Z","caller":"traceutil/trace.go:171","msg":"trace[860395019] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:588; }","duration":"469.706747ms","start":"2026-04-21T02:20:40.936458Z","end":"2026-04-21T02:20:41.406165Z","steps":["trace[860395019] 'agreement among raft nodes before linearized reading' (duration: 468.438879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.40621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:40.936449Z","time spent":"469.754028ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29593,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-21T02:20:41.405231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:40.935193Z","time spent":"469.882993ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:41.405262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.718172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.406573Z","caller":"traceutil/trace.go:171","msg":"trace[631833183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"128.041942ms","start":"2026-04-21T02:20:41.278519Z","end":"2026-04-21T02:20:41.406561Z","steps":["trace[631833183] 'agreement among raft nodes before linearized reading' (duration: 126.717083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.340706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.406641Z","caller":"traceutil/trace.go:171","msg":"trace[430128315] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"128.654016ms","start":"2026-04-21T02:20:41.277977Z","end":"2026-04-21T02:20:41.406631Z","steps":["trace[430128315] 'agreement among raft nodes before linearized reading' (duration: 127.364037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.477409ms","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-21T02:20:41.406703Z","caller":"traceutil/trace.go:171","msg":"trace[495907548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"128.765358ms","start":"2026-04-21T02:20:41.277908Z","end":"2026-04-21T02:20:41.406673Z","steps":["trace[495907548] 'agreement among raft nodes before linearized reading' (duration: 127.469489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.4679ms","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-21T02:20:41.406788Z","caller":"traceutil/trace.go:171","msg":"trace[1094619855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"156.850772ms","start":"2026-04-21T02:20:41.249928Z","end":"2026-04-21T02:20:41.406779Z","steps":["trace[1094619855] 'agreement among raft nodes before linearized reading' (duration: 155.4763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.529322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.406887Z","caller":"traceutil/trace.go:171","msg":"trace[73630871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"156.974146ms","start":"2026-04-21T02:20:41.249904Z","end":"2026-04-21T02:20:41.406878Z","steps":["trace[73630871] 'agreement among raft nodes before linearized reading' (duration: 155.523452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.512425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.406978Z","caller":"traceutil/trace.go:171","msg":"trace[729968884] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"189.068581ms","start":"2026-04-21T02:20:41.217903Z","end":"2026-04-21T02:20:41.406972Z","steps":["trace[729968884] 'agreement among raft nodes before linearized reading' (duration: 187.545055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.794212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407061Z","caller":"traceutil/trace.go:171","msg":"trace[829981761] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"110.405849ms","start":"2026-04-21T02:20:41.296643Z","end":"2026-04-21T02:20:41.407049Z","steps":["trace[829981761] 'agreement among raft nodes before linearized reading' (duration: 108.798442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.761554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407141Z","caller":"traceutil/trace.go:171","msg":"trace[517677551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"111.416622ms","start":"2026-04-21T02:20:41.295714Z","end":"2026-04-21T02:20:41.407131Z","steps":["trace[517677551] 'agreement among raft nodes before linearized reading' (duration: 109.761664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.40549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.985926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407265Z","caller":"traceutil/trace.go:171","msg":"trace[682985686] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"189.720926ms","start":"2026-04-21T02:20:41.217481Z","end":"2026-04-21T02:20:41.407202Z","steps":["trace[682985686] 'agreement among raft nodes before linearized reading' (duration: 187.991876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.809385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407387Z","caller":"traceutil/trace.go:171","msg":"trace[631988627] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"111.694599ms","start":"2026-04-21T02:20:41.295684Z","end":"2026-04-21T02:20:41.407378Z","steps":["trace[631988627] 'agreement among raft nodes before linearized reading' (duration: 109.816515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.15292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407472Z","caller":"traceutil/trace.go:171","msg":"trace[1026340085] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"190.111265ms","start":"2026-04-21T02:20:41.217352Z","end":"2026-04-21T02:20:41.407463Z","steps":["trace[1026340085] 'agreement among raft nodes before linearized reading' (duration: 188.15442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:41.405546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.293177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T02:20:41.405567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.108526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:41.407752Z","caller":"traceutil/trace.go:171","msg":"trace[1206088832] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:588; }","duration":"227.351007ms","start":"2026-04-21T02:20:41.18039Z","end":"2026-04-21T02:20:41.407741Z","steps":["trace[1206088832] 'agreement among raft nodes before linearized reading' (duration: 225.164677ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:41.407713Z","caller":"traceutil/trace.go:171","msg":"trace[959326111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"216.493748ms","start":"2026-04-21T02:20:41.19116Z","end":"2026-04-21T02:20:41.407654Z","steps":["trace[959326111] 'agreement among raft nodes before linearized reading' (duration: 214.373879ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:43.466Z","caller":"traceutil/trace.go:171","msg":"trace[1155175692] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"478.537101ms","start":"2026-04-21T02:20:42.987428Z","end":"2026-04-21T02:20:43.465965Z","steps":["trace[1155175692] 'process raft request' (duration: 478.356347ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:43.466042Z","caller":"traceutil/trace.go:171","msg":"trace[1627637658] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:625; }","duration":"275.273736ms","start":"2026-04-21T02:20:43.190735Z","end":"2026-04-21T02:20:43.466009Z","steps":["trace[1627637658] 'read index received' (duration: 275.259445ms)","trace[1627637658] 'applied index is now lower than readState.Index' (duration: 11.291µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:43.466175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:42.987382Z","time spent":"478.710975ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T02:20:43.466273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.507391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:43.466319Z","caller":"traceutil/trace.go:171","msg":"trace[1214498274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"275.608533ms","start":"2026-04-21T02:20:43.190698Z","end":"2026-04-21T02:20:43.466307Z","steps":["trace[1214498274] 'agreement among raft nodes before linearized reading' (duration: 275.46032ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:43.58033Z","caller":"traceutil/trace.go:171","msg":"trace[1972287794] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"369.402271ms","start":"2026-04-21T02:20:43.210886Z","end":"2026-04-21T02:20:43.580289Z","steps":["trace[1972287794] 'process raft request' (duration: 368.866589ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:43.580352Z","caller":"traceutil/trace.go:171","msg":"trace[298088886] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"156.383421ms","start":"2026-04-21T02:20:43.423929Z","end":"2026-04-21T02:20:43.580312Z","steps":["trace[298088886] 'process raft request' (duration: 156.205937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:43.580508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:43.210862Z","time spent":"369.566624ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T02:20:43.580319Z","caller":"traceutil/trace.go:171","msg":"trace[493886596] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"114.158244ms","start":"2026-04-21T02:20:43.466119Z","end":"2026-04-21T02:20:43.580277Z","steps":["trace[493886596] 'read index received' (duration: 113.571791ms)","trace[493886596] 'applied index is now lower than readState.Index' (duration: 584.963µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:43.580634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.968636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T02:20:43.580698Z","caller":"traceutil/trace.go:171","msg":"trace[330705068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"157.11337ms","start":"2026-04-21T02:20:43.423572Z","end":"2026-04-21T02:20:43.580686Z","steps":["trace[330705068] 'agreement among raft nodes before linearized reading' (duration: 156.828442ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:43.585025Z","caller":"traceutil/trace.go:171","msg":"trace[377018096] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"102.940359ms","start":"2026-04-21T02:20:43.482045Z","end":"2026-04-21T02:20:43.584985Z","steps":["trace[377018096] 'process raft request' (duration: 102.679803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:43.585264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.776138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:43.585301Z","caller":"traceutil/trace.go:171","msg":"trace[2099967309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"117.861839ms","start":"2026-04-21T02:20:43.467428Z","end":"2026-04-21T02:20:43.58529Z","steps":["trace[2099967309] 'agreement among raft nodes before linearized reading' (duration: 117.783698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.164767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.055115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T02:20:48.164891Z","caller":"traceutil/trace.go:171","msg":"trace[2130137305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"559.189538ms","start":"2026-04-21T02:20:47.605677Z","end":"2026-04-21T02:20:48.164867Z","steps":["trace[2130137305] 'range keys from in-memory index tree' (duration: 558.886201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.164936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:47.605654Z","time spent":"559.27164ms","remote":"127.0.0.1:53666","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-21T02:20:48.165021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.370853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T02:20:48.165165Z","caller":"traceutil/trace.go:171","msg":"trace[167515212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"559.592108ms","start":"2026-04-21T02:20:47.605536Z","end":"2026-04-21T02:20:48.165128Z","steps":["trace[167515212] 'range keys from in-memory index tree' (duration: 558.933953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.165389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:47.605504Z","time spent":"559.862183ms","remote":"127.0.0.1:53666","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-21T02:20:48.282346Z","caller":"traceutil/trace.go:171","msg":"trace[221737969] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"539.791724ms","start":"2026-04-21T02:20:47.742513Z","end":"2026-04-21T02:20:48.282305Z","steps":["trace[221737969] 'process raft request' (duration: 538.824012ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:48.28232Z","caller":"traceutil/trace.go:171","msg":"trace[365598835] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"443.694483ms","start":"2026-04-21T02:20:47.838595Z","end":"2026-04-21T02:20:48.282289Z","steps":["trace[365598835] 'read index received' (duration: 442.286431ms)","trace[365598835] 'applied index is now lower than readState.Index' (duration: 1.406922ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:48.282551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:47.742481Z","time spent":"539.963158ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:48.282828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.110463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pwr9k\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-21T02:20:48.282917Z","caller":"traceutil/trace.go:171","msg":"trace[900227814] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pwr9k; range_end:; response_count:1; response_revision:637; }","duration":"444.320147ms","start":"2026-04-21T02:20:47.838579Z","end":"2026-04-21T02:20:48.282899Z","steps":["trace[900227814] 'agreement among raft nodes before linearized reading' (duration: 443.828046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.282992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:47.838526Z","time spent":"444.45514ms","remote":"127.0.0.1:53588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-pwr9k\" "} {"level":"warn","ts":"2026-04-21T02:20:48.740015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.088233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:20:48.740355Z","caller":"traceutil/trace.go:171","msg":"trace[1778459295] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:659; }","duration":"457.740124ms","start":"2026-04-21T02:20:48.282602Z","end":"2026-04-21T02:20:48.740342Z","steps":["trace[1778459295] 'read index received' (duration: 126.138489ms)","trace[1778459295] 'applied index is now lower than readState.Index' (duration: 331.600735ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:20:48.740512Z","caller":"traceutil/trace.go:171","msg":"trace[933729937] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"569.180257ms","start":"2026-04-21T02:20:48.171293Z","end":"2026-04-21T02:20:48.740474Z","steps":["trace[933729937] 'process raft request' (duration: 568.993612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.740681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.386373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:48.740745Z","caller":"traceutil/trace.go:171","msg":"trace[2048860315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"549.529067ms","start":"2026-04-21T02:20:48.191198Z","end":"2026-04-21T02:20:48.740727Z","steps":["trace[2048860315] 'agreement among raft nodes before linearized reading' (duration: 549.353872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.740787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.191181Z","time spent":"549.597909ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T02:20:48.74074Z","caller":"traceutil/trace.go:171","msg":"trace[1818353288] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"573.839774ms","start":"2026-04-21T02:20:48.166856Z","end":"2026-04-21T02:20:48.740696Z","steps":["trace[1818353288] 'process raft request' (duration: 241.961522ms)","trace[1818353288] 'compare' (duration: 330.774136ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:48.740922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.646897ms","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-21T02:20:48.740516Z","caller":"traceutil/trace.go:171","msg":"trace[944934176] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"570.637499ms","start":"2026-04-21T02:20:48.169821Z","end":"2026-04-21T02:20:48.740459Z","steps":["trace[944934176] 'process raft request' (duration: 570.345323ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:48.741047Z","caller":"traceutil/trace.go:171","msg":"trace[1642913816] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:640; }","duration":"696.921053ms","start":"2026-04-21T02:20:48.044098Z","end":"2026-04-21T02:20:48.741019Z","steps":["trace[1642913816] 'agreement among raft nodes before linearized reading' (duration: 696.486532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.740718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.171246Z","time spent":"569.417782ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:48.741111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.04407Z","time spent":"697.026786ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T02:20:48.741139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.166758Z","time spent":"574.163941ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:48.741238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.169795Z","time spent":"571.287165ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:20:48.92614Z","caller":"traceutil/trace.go:171","msg":"trace[1227374477] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"185.691184ms","start":"2026-04-21T02:20:48.740422Z","end":"2026-04-21T02:20:48.926114Z","steps":["trace[1227374477] 'read index received' (duration: 137.219123ms)","trace[1227374477] 'applied index is now lower than readState.Index' (duration: 48.471021ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:20:48.926254Z","caller":"traceutil/trace.go:171","msg":"trace[287225699] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"570.857696ms","start":"2026-04-21T02:20:48.355369Z","end":"2026-04-21T02:20:48.926227Z","steps":["trace[287225699] 'process raft request' (duration: 570.692072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.926378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.355331Z","time spent":"570.976198ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T02:20:48.926416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.04436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:20:48.926454Z","caller":"traceutil/trace.go:171","msg":"trace[714076595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"237.201754ms","start":"2026-04-21T02:20:48.689241Z","end":"2026-04-21T02:20:48.926442Z","steps":["trace[714076595] 'agreement among raft nodes before linearized reading' (duration: 237.01615ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:20:48.92674Z","caller":"traceutil/trace.go:171","msg":"trace[175279421] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"628.180948ms","start":"2026-04-21T02:20:48.298311Z","end":"2026-04-21T02:20:48.926492Z","steps":["trace[175279421] 'process raft request' (duration: 579.315728ms)","trace[175279421] 'compare' (duration: 48.284627ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:20:48.926963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.298289Z","time spent":"628.554277ms","remote":"127.0.0.1:53588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:20:48.927224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.943074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T02:20:48.927763Z","caller":"traceutil/trace.go:171","msg":"trace[1231186334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"477.593718ms","start":"2026-04-21T02:20:48.450121Z","end":"2026-04-21T02:20:48.927715Z","steps":["trace[1231186334] 'agreement among raft nodes before linearized reading' (duration: 476.254468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.927886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:48.450096Z","time spent":"477.773413ms","remote":"127.0.0.1:53666","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-21T02:20:48.94502Z","caller":"traceutil/trace.go:171","msg":"trace[1308348806] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"199.079029ms","start":"2026-04-21T02:20:48.745901Z","end":"2026-04-21T02:20:48.94498Z","steps":["trace[1308348806] 'process raft request' (duration: 198.405744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:48.945037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.218198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:48.945103Z","caller":"traceutil/trace.go:171","msg":"trace[1509162511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"201.349501ms","start":"2026-04-21T02:20:48.743739Z","end":"2026-04-21T02:20:48.945089Z","steps":["trace[1509162511] 'agreement among raft nodes before linearized reading' (duration: 201.225568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:50.157667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.924481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:20:50.157751Z","caller":"traceutil/trace.go:171","msg":"trace[1665473648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"965.055384ms","start":"2026-04-21T02:20:49.192675Z","end":"2026-04-21T02:20:50.157731Z","steps":["trace[1665473648] 'range keys from in-memory index tree' (duration: 964.734997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:50.157794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:49.192657Z","time spent":"965.128685ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T02:20:50.163722Z","caller":"traceutil/trace.go:171","msg":"trace[167451911] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"815.663812ms","start":"2026-04-21T02:20:49.347837Z","end":"2026-04-21T02:20:50.163501Z","steps":["trace[167451911] 'process raft request' (duration: 813.929703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:20:50.163918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:20:49.347804Z","time spent":"815.992361ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:21:06.904261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.810155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:21:06.90433Z","caller":"traceutil/trace.go:171","msg":"trace[1701405086] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:772; }","duration":"639.930577ms","start":"2026-04-21T02:21:06.264387Z","end":"2026-04-21T02:21:06.904317Z","steps":["trace[1701405086] 'count revisions from in-memory index tree' (duration: 639.747843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:06.904358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:06.264371Z","time spent":"639.980659ms","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-04-21T02:21:07.084967Z","caller":"traceutil/trace.go:171","msg":"trace[1264192268] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"176.656076ms","start":"2026-04-21T02:21:06.908278Z","end":"2026-04-21T02:21:07.084934Z","steps":["trace[1264192268] 'process raft request' (duration: 108.980776ms)","trace[1264192268] 'compare' (duration: 67.478786ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:21:07.13501Z","caller":"traceutil/trace.go:171","msg":"trace[835395524] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"178.347385ms","start":"2026-04-21T02:21:06.956612Z","end":"2026-04-21T02:21:07.134959Z","steps":["trace[835395524] 'process raft request' (duration: 178.210652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.145933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12906082527111894141,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T02:21:43.469109Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.265818464s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T02:21:43.469583Z","caller":"traceutil/trace.go:171","msg":"trace[1307670725] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"824.683116ms","start":"2026-04-21T02:21:42.644862Z","end":"2026-04-21T02:21:43.469545Z","steps":["trace[1307670725] 'read index received' (duration: 824.476842ms)","trace[1307670725] 'applied index is now lower than readState.Index' (duration: 205.284µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:21:43.470101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.081384ms","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-21T02:21:43.470121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.388316ms","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-21T02:21:43.470169Z","caller":"traceutil/trace.go:171","msg":"trace[1822954476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"338.202687ms","start":"2026-04-21T02:21:43.13195Z","end":"2026-04-21T02:21:43.470153Z","steps":["trace[1822954476] 'agreement among raft nodes before linearized reading' (duration: 337.970252ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:21:43.470191Z","caller":"traceutil/trace.go:171","msg":"trace[96952036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:995; }","duration":"138.510649ms","start":"2026-04-21T02:21:43.331666Z","end":"2026-04-21T02:21:43.470177Z","steps":["trace[96952036] 'agreement among raft nodes before linearized reading' (duration: 138.280943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.470208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:43.131928Z","time spent":"338.271318ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T02:21:43.470422Z","caller":"traceutil/trace.go:171","msg":"trace[2025058613] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"1.267203096s","start":"2026-04-21T02:21:42.203211Z","end":"2026-04-21T02:21:43.470414Z","steps":["trace[2025058613] 'process raft request' (duration: 1.266195253s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.470451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.842334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T02:21:43.470481Z","caller":"traceutil/trace.go:171","msg":"trace[1394358190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:995; }","duration":"144.892905ms","start":"2026-04-21T02:21:43.325579Z","end":"2026-04-21T02:21:43.470472Z","steps":["trace[1394358190] 'agreement among raft nodes before linearized reading' (duration: 144.795333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.47049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:42.2032Z","time spent":"1.267240737s","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:21:43.4706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.14499ms","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-21T02:21:43.470616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.386502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:21:43.470622Z","caller":"traceutil/trace.go:171","msg":"trace[535988942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"224.202472ms","start":"2026-04-21T02:21:43.246413Z","end":"2026-04-21T02:21:43.470615Z","steps":["trace[535988942] 'agreement among raft nodes before linearized reading' (duration: 224.14473ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:21:43.47065Z","caller":"traceutil/trace.go:171","msg":"trace[1537235567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:995; }","duration":"147.456814ms","start":"2026-04-21T02:21:43.323186Z","end":"2026-04-21T02:21:43.470643Z","steps":["trace[1537235567] 'agreement among raft nodes before linearized reading' (duration: 147.358502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.470709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.827063ms","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-21T02:21:43.470786Z","caller":"traceutil/trace.go:171","msg":"trace[1414603175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:995; }","duration":"825.970046ms","start":"2026-04-21T02:21:42.644797Z","end":"2026-04-21T02:21:43.470767Z","steps":["trace[1414603175] 'agreement among raft nodes before linearized reading' (duration: 825.832973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.470847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:42.644783Z","time spent":"826.036137ms","remote":"127.0.0.1:48994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T02:21:43.748506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.843916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:21:43.748598Z","caller":"traceutil/trace.go:171","msg":"trace[1410813403] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"274.354487ms","start":"2026-04-21T02:21:43.474229Z","end":"2026-04-21T02:21:43.748584Z","steps":["trace[1410813403] 'process raft request' (duration: 155.390698ms)","trace[1410813403] 'compare' (duration: 118.696122ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:21:43.77812Z","caller":"traceutil/trace.go:171","msg":"trace[781506769] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"303.515737ms","start":"2026-04-21T02:21:43.47459Z","end":"2026-04-21T02:21:43.778105Z","steps":["trace[781506769] 'process raft request' (duration: 303.413935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.778221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:43.474572Z","time spent":"303.59928ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:21:43.778368Z","caller":"traceutil/trace.go:171","msg":"trace[1243034309] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"303.744463ms","start":"2026-04-21T02:21:43.474618Z","end":"2026-04-21T02:21:43.778363Z","steps":["trace[1243034309] 'process raft request' (duration: 303.457057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.778404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:43.474599Z","time spent":"303.786114ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:21:43.778427Z","caller":"traceutil/trace.go:171","msg":"trace[1950704046] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"303.722582ms","start":"2026-04-21T02:21:43.474689Z","end":"2026-04-21T02:21:43.778412Z","steps":["trace[1950704046] 'process raft request' (duration: 303.596209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.778529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:43.474643Z","time spent":"303.832115ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:21:43.778541Z","caller":"traceutil/trace.go:171","msg":"trace[163535305] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"303.290213ms","start":"2026-04-21T02:21:43.475232Z","end":"2026-04-21T02:21:43.778522Z","steps":["trace[163535305] 'process raft request' (duration: 303.15611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:21:43.778631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:21:43.475222Z","time spent":"303.358804ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:22:06.576665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.139765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T02:22:06.576763Z","caller":"traceutil/trace.go:171","msg":"trace[208015459] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1068; }","duration":"715.286828ms","start":"2026-04-21T02:22:05.861457Z","end":"2026-04-21T02:22:06.576744Z","steps":["trace[208015459] 'count revisions from in-memory index tree' (duration: 715.029913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.576809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.861435Z","time spent":"715.359031ms","remote":"127.0.0.1:49246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-21T02:22:06.577096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.009923ms","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-21T02:22:06.577127Z","caller":"traceutil/trace.go:171","msg":"trace[300470293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1068; }","duration":"702.087935ms","start":"2026-04-21T02:22:05.875028Z","end":"2026-04-21T02:22:06.577115Z","steps":["trace[300470293] 'range keys from in-memory index tree' (duration: 701.864981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.577153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.875006Z","time spent":"702.140947ms","remote":"127.0.0.1:53666","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-21T02:22:06.577327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.684577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T02:22:06.577353Z","caller":"traceutil/trace.go:171","msg":"trace[18257774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1068; }","duration":"701.730397ms","start":"2026-04-21T02:22:05.875615Z","end":"2026-04-21T02:22:06.577345Z","steps":["trace[18257774] 'range keys from in-memory index tree' (duration: 701.555403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.577377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.875602Z","time spent":"701.769378ms","remote":"127.0.0.1:53666","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-21T02:22:06.577524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.71401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:22:06.577548Z","caller":"traceutil/trace.go:171","msg":"trace[1829355675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1068; }","duration":"689.776812ms","start":"2026-04-21T02:22:05.887764Z","end":"2026-04-21T02:22:06.577541Z","steps":["trace[1829355675] 'range keys from in-memory index tree' (duration: 689.607667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.577576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.887739Z","time spent":"689.831542ms","remote":"127.0.0.1:53666","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-21T02:22:06.577788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.764203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T02:22:06.577746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.919324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:22:06.577819Z","caller":"traceutil/trace.go:171","msg":"trace[1106484311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1068; }","duration":"673.813785ms","start":"2026-04-21T02:22:05.903996Z","end":"2026-04-21T02:22:06.57781Z","steps":["trace[1106484311] 'range keys from in-memory index tree' (duration: 673.649811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.577845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.903983Z","time spent":"673.856085ms","remote":"127.0.0.1:53666","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-21T02:22:06.577847Z","caller":"traceutil/trace.go:171","msg":"trace[403069356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"385.056307ms","start":"2026-04-21T02:22:06.192765Z","end":"2026-04-21T02:22:06.577821Z","steps":["trace[403069356] 'range keys from in-memory index tree' (duration: 384.793051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.577902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:06.192747Z","time spent":"385.142318ms","remote":"127.0.0.1:53388","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-21T02:22:06.578003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.065958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T02:22:06.578028Z","caller":"traceutil/trace.go:171","msg":"trace[1475749941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1068; }","duration":"670.108948ms","start":"2026-04-21T02:22:05.907911Z","end":"2026-04-21T02:22:06.57802Z","steps":["trace[1475749941] 'range keys from in-memory index tree' (duration: 669.951565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:06.578052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:05.907902Z","time spent":"670.145129ms","remote":"127.0.0.1:53666","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-21T02:22:06.692621Z","caller":"traceutil/trace.go:171","msg":"trace[189460335] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"110.442293ms","start":"2026-04-21T02:22:06.58214Z","end":"2026-04-21T02:22:06.692583Z","steps":["trace[189460335] 'process raft request' (duration: 110.32978ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:06.773755Z","caller":"traceutil/trace.go:171","msg":"trace[174518725] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"190.556527ms","start":"2026-04-21T02:22:06.583176Z","end":"2026-04-21T02:22:06.773733Z","steps":["trace[174518725] 'process raft request' (duration: 190.2309ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:06.773895Z","caller":"traceutil/trace.go:171","msg":"trace[1511875625] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"191.252313ms","start":"2026-04-21T02:22:06.582636Z","end":"2026-04-21T02:22:06.773888Z","steps":["trace[1511875625] 'process raft request' (duration: 190.642389ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:06.773962Z","caller":"traceutil/trace.go:171","msg":"trace[1019226673] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"191.253333ms","start":"2026-04-21T02:22:06.582703Z","end":"2026-04-21T02:22:06.773957Z","steps":["trace[1019226673] 'process raft request' (duration: 190.67985ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:06.77402Z","caller":"traceutil/trace.go:171","msg":"trace[1531497145] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"190.750352ms","start":"2026-04-21T02:22:06.583264Z","end":"2026-04-21T02:22:06.774015Z","steps":["trace[1531497145] 'process raft request' (duration: 190.175789ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:08.109857Z","caller":"traceutil/trace.go:171","msg":"trace[1336049268] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"513.32223ms","start":"2026-04-21T02:22:07.596511Z","end":"2026-04-21T02:22:08.109833Z","steps":["trace[1336049268] 'process raft request' (duration: 513.136425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:08.110243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:07.596486Z","time spent":"513.460852ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:22:22.509626Z","caller":"traceutil/trace.go:171","msg":"trace[1945339082] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"216.468974ms","start":"2026-04-21T02:22:22.293105Z","end":"2026-04-21T02:22:22.509574Z","steps":["trace[1945339082] 'process raft request' (duration: 216.26851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:39.086276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.482821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T02:22:39.086329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.976754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T02:22:39.086455Z","caller":"traceutil/trace.go:171","msg":"trace[1321209317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"161.131127ms","start":"2026-04-21T02:22:38.925295Z","end":"2026-04-21T02:22:39.086426Z","steps":["trace[1321209317] 'range keys from in-memory index tree' (duration: 160.838711ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:39.086404Z","caller":"traceutil/trace.go:171","msg":"trace[751449782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"123.645554ms","start":"2026-04-21T02:22:38.96274Z","end":"2026-04-21T02:22:39.086386Z","steps":["trace[751449782] 'range keys from in-memory index tree' (duration: 123.344647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:39.08654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.099579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:22:39.086591Z","caller":"traceutil/trace.go:171","msg":"trace[1705185411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"178.186261ms","start":"2026-04-21T02:22:38.908393Z","end":"2026-04-21T02:22:39.08658Z","steps":["trace[1705185411] 'range keys from in-memory index tree' (duration: 177.990596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:39.086276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.550745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T02:22:39.086687Z","caller":"traceutil/trace.go:171","msg":"trace[1626236183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1245; }","duration":"169.016165ms","start":"2026-04-21T02:22:38.917661Z","end":"2026-04-21T02:22:39.086677Z","steps":["trace[1626236183] 'range keys from in-memory index tree' (duration: 168.424992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:39.086707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.290818ms","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-21T02:22:39.08673Z","caller":"traceutil/trace.go:171","msg":"trace[182100787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"124.329009ms","start":"2026-04-21T02:22:38.962394Z","end":"2026-04-21T02:22:39.086723Z","steps":["trace[182100787] 'range keys from in-memory index tree' (duration: 124.230917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:40.016177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.906024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:22:40.016259Z","caller":"traceutil/trace.go:171","msg":"trace[1163475398] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"413.716105ms","start":"2026-04-21T02:22:39.602532Z","end":"2026-04-21T02:22:40.016248Z","steps":["trace[1163475398] 'read index received' (duration: 33.608187ms)","trace[1163475398] 'applied index is now lower than readState.Index' (duration: 380.106368ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:22:40.016372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.836528ms","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-21T02:22:40.016321Z","caller":"traceutil/trace.go:171","msg":"trace[407976696] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"419.590117ms","start":"2026-04-21T02:22:39.596685Z","end":"2026-04-21T02:22:40.016275Z","steps":["trace[407976696] 'process raft request' (duration: 39.523139ms)","trace[407976696] 'compare' (duration: 378.952563ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:22:40.016398Z","caller":"traceutil/trace.go:171","msg":"trace[671788276] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1255; }","duration":"413.894889ms","start":"2026-04-21T02:22:39.602496Z","end":"2026-04-21T02:22:40.016391Z","steps":["trace[671788276] 'agreement among raft nodes before linearized reading' (duration: 413.816617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:40.016511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:39.602485Z","time spent":"414.020342ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-21T02:22:40.016529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:39.596657Z","time spent":"419.770061ms","remote":"127.0.0.1:53488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T02:22:40.606821Z","caller":"traceutil/trace.go:171","msg":"trace[429075221] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"585.945533ms","start":"2026-04-21T02:22:40.020821Z","end":"2026-04-21T02:22:40.606767Z","steps":["trace[429075221] 'process raft request' (duration: 507.678441ms)","trace[429075221] 'compare' (duration: 77.695979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:22:40.607102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:40.020795Z","time spent":"586.22094ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T02:22:40.704511Z","caller":"traceutil/trace.go:171","msg":"trace[842099564] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1304; }","duration":"512.358566ms","start":"2026-04-21T02:22:40.192127Z","end":"2026-04-21T02:22:40.704485Z","steps":["trace[842099564] 'read index received' (duration: 336.585168ms)","trace[842099564] 'applied index is now lower than readState.Index' (duration: 175.772408ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:22:40.704769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.624152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:22:40.704808Z","caller":"traceutil/trace.go:171","msg":"trace[15730174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"512.732164ms","start":"2026-04-21T02:22:40.192065Z","end":"2026-04-21T02:22:40.704797Z","steps":["trace[15730174] 'agreement among raft nodes before linearized reading' (duration: 512.574601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:40.704875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:40.192035Z","time spent":"512.832337ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T02:22:41.544332Z","caller":"traceutil/trace.go:171","msg":"trace[2114441376] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"364.471827ms","start":"2026-04-21T02:22:41.179826Z","end":"2026-04-21T02:22:41.544298Z","steps":["trace[2114441376] 'read index received' (duration: 364.248362ms)","trace[2114441376] 'applied index is now lower than readState.Index' (duration: 221.835µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:22:41.544808Z","caller":"traceutil/trace.go:171","msg":"trace[1872680268] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"408.234721ms","start":"2026-04-21T02:22:41.136555Z","end":"2026-04-21T02:22:41.544789Z","steps":["trace[1872680268] 'process raft request' (duration: 407.540216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:41.545004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.136532Z","time spent":"408.351685ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:22:41.545104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.237033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T02:22:41.545198Z","caller":"traceutil/trace.go:171","msg":"trace[726560223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"365.395197ms","start":"2026-04-21T02:22:41.179782Z","end":"2026-04-21T02:22:41.545177Z","steps":["trace[726560223] 'agreement among raft nodes before linearized reading' (duration: 365.116011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:41.545253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.179762Z","time spent":"365.482429ms","remote":"127.0.0.1:53666","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-21T02:22:42.045286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12906082527111894767,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T02:22:42.146322Z","caller":"traceutil/trace.go:171","msg":"trace[1097421251] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"731.695105ms","start":"2026-04-21T02:22:41.414599Z","end":"2026-04-21T02:22:42.146294Z","steps":["trace[1097421251] 'process raft request' (duration: 731.48066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:42.146549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.414564Z","time spent":"731.833509ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:22:42.15488Z","caller":"traceutil/trace.go:171","msg":"trace[2135552948] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1310; }","duration":"610.422385ms","start":"2026-04-21T02:22:41.544427Z","end":"2026-04-21T02:22:42.15485Z","steps":["trace[2135552948] 'read index received' (duration: 601.683758ms)","trace[2135552948] 'applied index is now lower than readState.Index' (duration: 8.737377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:22:42.154939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.541325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:22:42.154965Z","caller":"traceutil/trace.go:171","msg":"trace[195026735] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"605.673577ms","start":"2026-04-21T02:22:41.54926Z","end":"2026-04-21T02:22:42.154933Z","steps":["trace[195026735] 'process raft request' (duration: 605.420671ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:42.15501Z","caller":"traceutil/trace.go:171","msg":"trace[990948644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"963.639347ms","start":"2026-04-21T02:22:41.191355Z","end":"2026-04-21T02:22:42.154994Z","steps":["trace[990948644] 'agreement among raft nodes before linearized reading' (duration: 963.526185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:42.15504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.191345Z","time spent":"963.689118ms","remote":"127.0.0.1:53388","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-21T02:22:42.155059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.955562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T02:22:42.155105Z","caller":"traceutil/trace.go:171","msg":"trace[2064091306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1262; }","duration":"975.056994ms","start":"2026-04-21T02:22:41.180033Z","end":"2026-04-21T02:22:42.15509Z","steps":["trace[2064091306] 'agreement among raft nodes before linearized reading' (duration: 974.909431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:42.155131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.133406ms","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-21T02:22:42.155131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.069494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T02:22:42.155162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.180006Z","time spent":"975.145617ms","remote":"127.0.0.1:53666","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-21T02:22:42.155112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.549235Z","time spent":"605.7946ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:22:42.155172Z","caller":"traceutil/trace.go:171","msg":"trace[252294949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1262; }","duration":"975.215508ms","start":"2026-04-21T02:22:41.179942Z","end":"2026-04-21T02:22:42.155157Z","steps":["trace[252294949] 'agreement among raft nodes before linearized reading' (duration: 975.047234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:42.155219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.179927Z","time spent":"975.28135ms","remote":"127.0.0.1:53666","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":"info","ts":"2026-04-21T02:22:42.155175Z","caller":"traceutil/trace.go:171","msg":"trace[1836485934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1262; }","duration":"975.133856ms","start":"2026-04-21T02:22:41.180028Z","end":"2026-04-21T02:22:42.155162Z","steps":["trace[1836485934] 'agreement among raft nodes before linearized reading' (duration: 974.940922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:42.155291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:41.180002Z","time spent":"975.28119ms","remote":"127.0.0.1:53666","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-21T02:22:42.401028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.385634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:22:42.401271Z","caller":"traceutil/trace.go:171","msg":"trace[1146340766] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"239.585916ms","start":"2026-04-21T02:22:42.161659Z","end":"2026-04-21T02:22:42.401245Z","steps":["trace[1146340766] 'process raft request' (duration: 239.487364ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:42.401262Z","caller":"traceutil/trace.go:171","msg":"trace[1159332099] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"241.5561ms","start":"2026-04-21T02:22:42.159661Z","end":"2026-04-21T02:22:42.401217Z","steps":["trace[1159332099] 'process raft request' (duration: 139.8662ms)","trace[1159332099] 'compare' (duration: 101.136557ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:22:52.380381Z","caller":"traceutil/trace.go:171","msg":"trace[1168007762] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"158.525669ms","start":"2026-04-21T02:22:52.22183Z","end":"2026-04-21T02:22:52.380356Z","steps":["trace[1168007762] 'read index received' (duration: 158.161091ms)","trace[1168007762] 'applied index is now lower than readState.Index' (duration: 363.468µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:22:52.380469Z","caller":"traceutil/trace.go:171","msg":"trace[1809963815] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"164.959324ms","start":"2026-04-21T02:22:52.215473Z","end":"2026-04-21T02:22:52.380432Z","steps":["trace[1809963815] 'process raft request' (duration: 164.601296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.380668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.814746ms","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-21T02:22:52.380711Z","caller":"traceutil/trace.go:171","msg":"trace[685480567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1334; }","duration":"158.914438ms","start":"2026-04-21T02:22:52.221785Z","end":"2026-04-21T02:22:52.380699Z","steps":["trace[685480567] 'agreement among raft nodes before linearized reading' (duration: 158.707903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.380956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.037041ms","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-21T02:22:52.380999Z","caller":"traceutil/trace.go:171","msg":"trace[402862529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1334; }","duration":"159.160133ms","start":"2026-04-21T02:22:52.221829Z","end":"2026-04-21T02:22:52.380989Z","steps":["trace[402862529] 'agreement among raft nodes before linearized reading' (duration: 158.948009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.92647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.350363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T02:22:52.926667Z","caller":"traceutil/trace.go:171","msg":"trace[1430822867] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1386; }","duration":"478.688088ms","start":"2026-04-21T02:22:52.447956Z","end":"2026-04-21T02:22:52.926644Z","steps":["trace[1430822867] 'read index received' (duration: 440.063489ms)","trace[1430822867] 'applied index is now lower than readState.Index' (duration: 38.622919ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:22:52.926762Z","caller":"traceutil/trace.go:171","msg":"trace[1427323594] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"533.107822ms","start":"2026-04-21T02:22:52.393644Z","end":"2026-04-21T02:22:52.926752Z","steps":["trace[1427323594] 'process raft request' (duration: 532.920288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.92686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:52.39362Z","time spent":"533.173844ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T02:22:52.926957Z","caller":"traceutil/trace.go:171","msg":"trace[1702705420] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"533.273137ms","start":"2026-04-21T02:22:52.393578Z","end":"2026-04-21T02:22:52.926851Z","steps":["trace[1702705420] 'process raft request' (duration: 45.435343ms)","trace[1702705420] 'compare' (duration: 487.171139ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:22:52.927242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:52.393552Z","time spent":"533.547162ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T02:22:52.927003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.977814ms","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-21T02:22:52.927661Z","caller":"traceutil/trace.go:171","msg":"trace[473082670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1336; }","duration":"479.760021ms","start":"2026-04-21T02:22:52.447882Z","end":"2026-04-21T02:22:52.927642Z","steps":["trace[473082670] 'agreement among raft nodes before linearized reading' (duration: 478.885972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.927736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:52.447865Z","time spent":"479.853194ms","remote":"127.0.0.1:53666","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":"info","ts":"2026-04-21T02:22:52.957673Z","caller":"traceutil/trace.go:171","msg":"trace[1844307489] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"161.431024ms","start":"2026-04-21T02:22:52.796222Z","end":"2026-04-21T02:22:52.957653Z","steps":["trace[1844307489] 'process raft request' (duration: 161.350982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.95776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.271602ms","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-21T02:22:52.957789Z","caller":"traceutil/trace.go:171","msg":"trace[1708668094] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1337; }","duration":"221.346813ms","start":"2026-04-21T02:22:52.736435Z","end":"2026-04-21T02:22:52.957782Z","steps":["trace[1708668094] 'agreement among raft nodes before linearized reading' (duration: 221.21282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.957918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.183659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:22:52.957994Z","caller":"traceutil/trace.go:171","msg":"trace[1204033675] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1337; }","duration":"471.297341ms","start":"2026-04-21T02:22:52.486685Z","end":"2026-04-21T02:22:52.957982Z","steps":["trace[1204033675] 'agreement among raft nodes before linearized reading' (duration: 471.188689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.957967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.534547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T02:22:52.958022Z","caller":"traceutil/trace.go:171","msg":"trace[1371038448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1337; }","duration":"507.627869ms","start":"2026-04-21T02:22:52.450389Z","end":"2026-04-21T02:22:52.958017Z","steps":["trace[1371038448] 'agreement among raft nodes before linearized reading' (duration: 507.249401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:22:52.958037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:52.450362Z","time spent":"507.670701ms","remote":"127.0.0.1:53666","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-21T02:22:52.958027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T02:22:52.486668Z","time spent":"471.348352ms","remote":"127.0.0.1:36006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-21T02:22:53.12575Z","caller":"traceutil/trace.go:171","msg":"trace[904271518] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"193.901645ms","start":"2026-04-21T02:22:52.931823Z","end":"2026-04-21T02:22:53.125725Z","steps":["trace[904271518] 'process raft request' (duration: 193.761532ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:53.126925Z","caller":"traceutil/trace.go:171","msg":"trace[616585281] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"163.341097ms","start":"2026-04-21T02:22:52.963565Z","end":"2026-04-21T02:22:53.126906Z","steps":["trace[616585281] 'process raft request' (duration: 163.255075ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:22:53.127246Z","caller":"traceutil/trace.go:171","msg":"trace[107169764] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"164.113735ms","start":"2026-04-21T02:22:52.963079Z","end":"2026-04-21T02:22:53.127193Z","steps":["trace[107169764] 'process raft request' (duration: 163.614694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:23:49.547814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.963267ms","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-21T02:23:49.547911Z","caller":"traceutil/trace.go:171","msg":"trace[154650472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1596; }","duration":"101.117861ms","start":"2026-04-21T02:23:49.446769Z","end":"2026-04-21T02:23:49.547887Z","steps":["trace[154650472] 'range keys from in-memory index tree' (duration: 100.769302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:23:49.548046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.62507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T02:23:49.548145Z","caller":"traceutil/trace.go:171","msg":"trace[1341021564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1596; }","duration":"113.784764ms","start":"2026-04-21T02:23:49.434339Z","end":"2026-04-21T02:23:49.548124Z","steps":["trace[1341021564] 'range keys from in-memory index tree' (duration: 113.051848ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:26:06.199242Z","caller":"traceutil/trace.go:171","msg":"trace[2051069311] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"154.042995ms","start":"2026-04-21T02:26:06.045168Z","end":"2026-04-21T02:26:06.199211Z","steps":["trace[2051069311] 'process raft request' (duration: 153.787579ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T02:26:06.326677Z","caller":"traceutil/trace.go:171","msg":"trace[438941110] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"280.470948ms","start":"2026-04-21T02:26:06.046173Z","end":"2026-04-21T02:26:06.326644Z","steps":["trace[438941110] 'process raft request' (duration: 243.616869ms)","trace[438941110] 'compare' (duration: 36.546332ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T02:26:06.326685Z","caller":"traceutil/trace.go:171","msg":"trace[1208165296] linearizableReadLoop","detail":"{readStateIndex:2337; appliedIndex:2335; }","duration":"134.444044ms","start":"2026-04-21T02:26:06.192077Z","end":"2026-04-21T02:26:06.326521Z","steps":["trace[1208165296] 'read index received' (duration: 7.016918ms)","trace[1208165296] 'applied index is now lower than readState.Index' (duration: 127.425696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T02:26:06.327236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.825823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T02:26:06.327334Z","caller":"traceutil/trace.go:171","msg":"trace[1455100296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2245; }","duration":"135.297333ms","start":"2026-04-21T02:26:06.192012Z","end":"2026-04-21T02:26:06.32731Z","steps":["trace[1455100296] 'agreement among raft nodes before linearized reading' (duration: 134.830603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T02:26:06.327689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.897179ms","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":"info","ts":"2026-04-21T02:26:06.327742Z","caller":"traceutil/trace.go:171","msg":"trace[281290281] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2245; }","duration":"125.007782ms","start":"2026-04-21T02:26:06.202721Z","end":"2026-04-21T02:26:06.327729Z","steps":["trace[281290281] 'agreement among raft nodes before linearized reading' (duration: 124.173783ms)"],"step_count":1}