{"level":"warn","ts":"2026-07-30T19:28:24.704431Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T19:28:24.704523Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-07-30T19:28:24.704597Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T19:28:24.704604Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-30T19:28:24.704631Z","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-07-30T19:28:24.705299Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-07-30T19:28:24.705399Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-07-30T19:28:24.708273Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.668654ms"} {"level":"info","ts":"2026-07-30T19:28:24.712681Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-07-30T19:28:24.712739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T19:28:24.71276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-07-30T19:28:24.712769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T19:28:24.712776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-07-30T19:28:24.712807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-07-30T19:28:24.720911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T19:28:24.724852Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T19:28:24.726339Z","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-07-30T19:28:24.729093Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T19:28:24.729384Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T19:28:24.729468Z","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-07-30T19:28:24.729517Z","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-07-30T19:28:24.729524Z","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-07-30T19:28:24.731397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-07-30T19:28:24.733445Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-30T19:28:24.736682Z","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-07-30T19:28:24.737046Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T19:28:24.737086Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T19:28:24.737746Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-30T19:28:24.737798Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-30T19:28:25.012948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T19:28:25.013015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T19:28:25.013068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-07-30T19:28:25.013165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-07-30T19:28:25.013225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-30T19:28:25.013316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-07-30T19:28:25.013364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-30T19:28:25.014254Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T19:28:25.015228Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T19:28:25.015254Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T19:28:25.015616Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T19:28:25.015807Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T19:28:25.015848Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T19:28:25.015989Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T19:28:25.016012Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T19:28:25.017513Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T19:28:25.018966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T19:28:25.020646Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-07-30T19:28:53.07258Z","caller":"traceutil/trace.go:171","msg":"trace[239167684] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"311.100189ms","start":"2026-07-30T19:28:52.761452Z","end":"2026-07-30T19:28:53.072553Z","steps":["trace[239167684] 'read index received' (duration: 310.871333ms)","trace[239167684] 'applied index is now lower than readState.Index' (duration: 227.546µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:28:53.072697Z","caller":"traceutil/trace.go:171","msg":"trace[231576810] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"312.324731ms","start":"2026-07-30T19:28:52.760341Z","end":"2026-07-30T19:28:53.072665Z","steps":["trace[231576810] 'process raft request' (duration: 312.063934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:28:53.072755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.277524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:28:53.072823Z","caller":"traceutil/trace.go:171","msg":"trace[313977128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"311.387826ms","start":"2026-07-30T19:28:52.761413Z","end":"2026-07-30T19:28:53.072801Z","steps":["trace[313977128] 'agreement among raft nodes before linearized reading' (duration: 311.250513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:28:53.072856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:28:52.761398Z","time spent":"311.450308ms","remote":"127.0.0.1:51606","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-07-30T19:28:53.073217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:28:52.760325Z","time spent":"312.422653ms","remote":"127.0.0.1:51854","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-07-30T19:29:01.60194Z","caller":"traceutil/trace.go:171","msg":"trace[167089221] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"343.438071ms","start":"2026-07-30T19:29:01.258472Z","end":"2026-07-30T19:29:01.601911Z","steps":["trace[167089221] 'process raft request' (duration: 343.198465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.602189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.258439Z","time spent":"343.647036ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.608909Z","caller":"traceutil/trace.go:171","msg":"trace[1186783322] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"348.49419ms","start":"2026-07-30T19:29:01.26039Z","end":"2026-07-30T19:29:01.608885Z","steps":["trace[1186783322] 'process raft request' (duration: 348.315755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.610265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.260372Z","time spent":"349.777582ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.610691Z","caller":"traceutil/trace.go:171","msg":"trace[506083292] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"334.225977ms","start":"2026-07-30T19:29:01.276301Z","end":"2026-07-30T19:29:01.610527Z","steps":["trace[506083292] 'process raft request' (duration: 332.541654ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:01.610729Z","caller":"traceutil/trace.go:171","msg":"trace[816102860] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"350.048479ms","start":"2026-07-30T19:29:01.260528Z","end":"2026-07-30T19:29:01.610577Z","steps":["trace[816102860] 'process raft request' (duration: 348.224983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.610841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.260525Z","time spent":"350.288815ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:01.610875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.276289Z","time spent":"334.459682ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.611046Z","caller":"traceutil/trace.go:171","msg":"trace[2096669262] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"339.87471ms","start":"2026-07-30T19:29:01.271034Z","end":"2026-07-30T19:29:01.610908Z","steps":["trace[2096669262] 'process raft request' (duration: 337.769167ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:01.611019Z","caller":"traceutil/trace.go:171","msg":"trace[1714521362] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"334.209577ms","start":"2026-07-30T19:29:01.276355Z","end":"2026-07-30T19:29:01.610564Z","steps":["trace[1714521362] 'process raft request' (duration: 332.515104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.611145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.27101Z","time spent":"340.082126ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:01.611173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.276336Z","time spent":"334.775771ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.611527Z","caller":"traceutil/trace.go:171","msg":"trace[789455315] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"334.902634ms","start":"2026-07-30T19:29:01.276422Z","end":"2026-07-30T19:29:01.611325Z","steps":["trace[789455315] 'process raft request' (duration: 332.821591ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:01.611655Z","caller":"traceutil/trace.go:171","msg":"trace[1734771651] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"335.175721ms","start":"2026-07-30T19:29:01.276354Z","end":"2026-07-30T19:29:01.611529Z","steps":["trace[1734771651] 'process raft request' (duration: 332.544054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.611863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.276414Z","time spent":"335.205982ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:01.611916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.276334Z","time spent":"335.353835ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.614619Z","caller":"traceutil/trace.go:171","msg":"trace[262161037] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"334.115105ms","start":"2026-07-30T19:29:01.279865Z","end":"2026-07-30T19:29:01.61398Z","steps":["trace[262161037] 'process raft request' (duration: 330.639456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.614719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.279856Z","time spent":"334.812542ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:01.615156Z","caller":"traceutil/trace.go:171","msg":"trace[374657651] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"193.91415ms","start":"2026-07-30T19:29:01.421223Z","end":"2026-07-30T19:29:01.615138Z","steps":["trace[374657651] 'process raft request' (duration: 193.788237ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:01.61531Z","caller":"traceutil/trace.go:171","msg":"trace[1287313066] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"327.343212ms","start":"2026-07-30T19:29:01.287949Z","end":"2026-07-30T19:29:01.615292Z","steps":["trace[1287313066] 'process raft request' (duration: 326.86044ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:01.615328Z","caller":"traceutil/trace.go:171","msg":"trace[470101381] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"313.619823ms","start":"2026-07-30T19:29:01.301697Z","end":"2026-07-30T19:29:01.615317Z","steps":["trace[470101381] 'process raft request' (duration: 313.200982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:01.615391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.301671Z","time spent":"313.682875ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:01.615473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:01.287939Z","time spent":"327.408343ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:07.43137Z","caller":"traceutil/trace.go:171","msg":"trace[1945055037] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"180.724645ms","start":"2026-07-30T19:29:07.25062Z","end":"2026-07-30T19:29:07.431344Z","steps":["trace[1945055037] 'process raft request' (duration: 180.185541ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:07.481819Z","caller":"traceutil/trace.go:171","msg":"trace[2038620729] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"191.105628ms","start":"2026-07-30T19:29:07.290689Z","end":"2026-07-30T19:29:07.481795Z","steps":["trace[2038620729] 'process raft request' (duration: 167.429817ms)","trace[2038620729] 'compare' (duration: 23.528298ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:29:08.505517Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700946183097709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T19:29:08.775456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113948791s","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-07-30T19:29:08.77554Z","caller":"traceutil/trace.go:171","msg":"trace[917479607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"1.114081484s","start":"2026-07-30T19:29:07.66144Z","end":"2026-07-30T19:29:08.775521Z","steps":["trace[917479607] 'range keys from in-memory index tree' (duration: 1.113811437s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:08.775579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:07.661419Z","time spent":"1.114151255s","remote":"127.0.0.1:51854","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-07-30T19:29:08.775602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.145452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sw9xp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-30T19:29:08.775677Z","caller":"traceutil/trace.go:171","msg":"trace[715822658] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sw9xp; range_end:; response_count:1; response_revision:630; }","duration":"837.264365ms","start":"2026-07-30T19:29:07.938392Z","end":"2026-07-30T19:29:08.775656Z","steps":["trace[715822658] 'range keys from in-memory index tree' (duration: 836.986539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:08.775719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:07.93837Z","time spent":"837.340998ms","remote":"127.0.0.1:51762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-sw9xp\" "} {"level":"info","ts":"2026-07-30T19:29:08.776323Z","caller":"traceutil/trace.go:171","msg":"trace[257801305] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"770.899859ms","start":"2026-07-30T19:29:08.005407Z","end":"2026-07-30T19:29:08.776307Z","steps":["trace[257801305] 'read index received' (duration: 701.803412ms)","trace[257801305] 'applied index is now lower than readState.Index' (duration: 69.095357ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:29:08.776391Z","caller":"traceutil/trace.go:171","msg":"trace[1658379553] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"826.778119ms","start":"2026-07-30T19:29:07.949584Z","end":"2026-07-30T19:29:08.776362Z","steps":["trace[1658379553] 'process raft request' (duration: 757.95724ms)","trace[1658379553] 'compare' (duration: 67.872015ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:29:08.776491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.671738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-30T19:29:08.77654Z","caller":"traceutil/trace.go:171","msg":"trace[806865419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"570.72261ms","start":"2026-07-30T19:29:08.205805Z","end":"2026-07-30T19:29:08.776527Z","steps":["trace[806865419] 'agreement among raft nodes before linearized reading' (duration: 570.605717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:08.776559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:07.949553Z","time spent":"826.922643ms","remote":"127.0.0.1:51672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:29:08.776576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.205755Z","time spent":"570.813812ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T19:29:08.776937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.504134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-30T19:29:08.777022Z","caller":"traceutil/trace.go:171","msg":"trace[1176616258] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:631; }","duration":"771.636948ms","start":"2026-07-30T19:29:08.005363Z","end":"2026-07-30T19:29:08.777Z","steps":["trace[1176616258] 'agreement among raft nodes before linearized reading' (duration: 771.022872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:08.777139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.005347Z","time spent":"771.779601ms","remote":"127.0.0.1:51622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" "} {"level":"warn","ts":"2026-07-30T19:29:09.643362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700946183097713,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T19:29:10.0149Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.233628222s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-30T19:29:10.851779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.432335ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-07-30T19:29:10.852037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.781151Z","time spent":"2.070880247s","remote":"127.0.0.1:51622","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-30T19:29:10.852149Z","caller":"traceutil/trace.go:171","msg":"trace[336558225] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"2.07058517s","start":"2026-07-30T19:29:08.781547Z","end":"2026-07-30T19:29:10.852132Z","steps":["trace[336558225] 'process raft request' (duration: 2.070458217s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:10.852253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.781525Z","time spent":"2.070669871s","remote":"127.0.0.1:51854","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-07-30T19:29:10.852236Z","caller":"traceutil/trace.go:171","msg":"trace[1124672760] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"2.070763344s","start":"2026-07-30T19:29:08.781414Z","end":"2026-07-30T19:29:10.852177Z","steps":["trace[1124672760] 'process raft request' (duration: 2.070459696s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:10.852323Z","caller":"traceutil/trace.go:171","msg":"trace[1563384600] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.057466956s","start":"2026-07-30T19:29:08.794839Z","end":"2026-07-30T19:29:10.852306Z","steps":["trace[1563384600] 'process raft request' (duration: 2.057341843s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:10.852349Z","caller":"traceutil/trace.go:171","msg":"trace[614436520] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"2.069834491s","start":"2026-07-30T19:29:08.782497Z","end":"2026-07-30T19:29:10.852331Z","steps":["trace[614436520] 'process raft request' (duration: 2.069598515s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:10.852382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.709523651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-30T19:29:10.852442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.794829Z","time spent":"2.057533268s","remote":"127.0.0.1:51762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:29:10.852443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.78248Z","time spent":"2.069915042s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:29:10.852421Z","caller":"traceutil/trace.go:171","msg":"trace[839640364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"1.709603833s","start":"2026-07-30T19:29:09.142807Z","end":"2026-07-30T19:29:10.852411Z","steps":["trace[839640364] 'agreement among raft nodes before linearized reading' (duration: 1.709529251s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:10.852516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:09.142783Z","time spent":"1.709721945s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-30T19:29:10.852553Z","caller":"traceutil/trace.go:171","msg":"trace[1928794168] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"2.019215784s","start":"2026-07-30T19:29:08.833319Z","end":"2026-07-30T19:29:10.852535Z","steps":["trace[1928794168] 'process raft request' (duration: 2.018918756s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:10.852298Z","caller":"traceutil/trace.go:171","msg":"trace[814718270] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:652; }","duration":"1.709413727s","start":"2026-07-30T19:29:09.14286Z","end":"2026-07-30T19:29:10.852274Z","steps":["trace[814718270] 'read index received' (duration: 872.238174ms)","trace[814718270] 'applied index is now lower than readState.Index' (duration: 837.174603ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:29:10.852621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.83329Z","time spent":"2.019299686s","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:10.852724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090404342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:29:10.85276Z","caller":"traceutil/trace.go:171","msg":"trace[279580217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.090476574s","start":"2026-07-30T19:29:09.762272Z","end":"2026-07-30T19:29:10.852749Z","steps":["trace[279580217] 'agreement among raft nodes before linearized reading' (duration: 1.090412272s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:10.852788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:09.762257Z","time spent":"1.090525554s","remote":"127.0.0.1:51606","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-07-30T19:29:10.852873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:08.781402Z","time spent":"2.070979969s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:29:12.527589Z","caller":"traceutil/trace.go:171","msg":"trace[2111760951] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"441.247217ms","start":"2026-07-30T19:29:12.08632Z","end":"2026-07-30T19:29:12.527567Z","steps":["trace[2111760951] 'process raft request' (duration: 441.168925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:12.52771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:12.08631Z","time spent":"441.34682ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T19:29:12.527749Z","caller":"traceutil/trace.go:171","msg":"trace[165385312] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"441.712419ms","start":"2026-07-30T19:29:12.086007Z","end":"2026-07-30T19:29:12.52772Z","steps":["trace[165385312] 'process raft request' (duration: 371.371031ms)","trace[165385312] 'compare' (duration: 69.990079ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:29:12.528006Z","caller":"traceutil/trace.go:171","msg":"trace[1906168573] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"440.142719ms","start":"2026-07-30T19:29:12.087853Z","end":"2026-07-30T19:29:12.527996Z","steps":["trace[1906168573] 'process raft request' (duration: 439.689658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:12.528065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:12.087841Z","time spent":"440.202392ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:12.528096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.64557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:29:12.528144Z","caller":"traceutil/trace.go:171","msg":"trace[1792804233] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:660; }","duration":"436.729123ms","start":"2026-07-30T19:29:12.091402Z","end":"2026-07-30T19:29:12.528131Z","steps":["trace[1792804233] 'agreement among raft nodes before linearized reading' (duration: 436.63561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:12.528157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:12.085998Z","time spent":"441.821902ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:29:12.528004Z","caller":"traceutil/trace.go:171","msg":"trace[72906936] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:678; }","duration":"436.331583ms","start":"2026-07-30T19:29:12.091438Z","end":"2026-07-30T19:29:12.527769Z","steps":["trace[72906936] 'read index received' (duration: 365.973004ms)","trace[72906936] 'applied index is now lower than readState.Index' (duration: 70.357729ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:29:12.528218Z","caller":"traceutil/trace.go:171","msg":"trace[447736545] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"438.452937ms","start":"2026-07-30T19:29:12.089753Z","end":"2026-07-30T19:29:12.528205Z","steps":["trace[447736545] 'process raft request' (duration: 437.972885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:12.528282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:12.089743Z","time spent":"438.507328ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T19:29:12.528182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:12.091385Z","time spent":"436.787615ms","remote":"127.0.0.1:51642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-07-30T19:29:12.52833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.508517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:29:12.529133Z","caller":"traceutil/trace.go:171","msg":"trace[1509884624] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:660; }","duration":"247.304547ms","start":"2026-07-30T19:29:12.281812Z","end":"2026-07-30T19:29:12.529116Z","steps":["trace[1509884624] 'agreement among raft nodes before linearized reading' (duration: 246.492836ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:29:15.25191Z","caller":"traceutil/trace.go:171","msg":"trace[1821014979] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"112.968302ms","start":"2026-07-30T19:29:15.138867Z","end":"2026-07-30T19:29:15.251835Z","steps":["trace[1821014979] 'process raft request' (duration: 112.765607ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:26.238998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.945985ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-30T19:29:26.239443Z","caller":"traceutil/trace.go:171","msg":"trace[5353943] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"502.78268ms","start":"2026-07-30T19:29:25.736642Z","end":"2026-07-30T19:29:26.239424Z","steps":["trace[5353943] 'read index received' (duration: 62.412µs)","trace[5353943] 'applied index is now lower than readState.Index' (duration: 502.718398ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:29:26.239701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.048297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:29:26.239772Z","caller":"traceutil/trace.go:171","msg":"trace[1421798986] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:795; }","duration":"503.172351ms","start":"2026-07-30T19:29:25.736588Z","end":"2026-07-30T19:29:26.239761Z","steps":["trace[1421798986] 'agreement among raft nodes before linearized reading' (duration: 502.982905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:26.239909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:25.736568Z","time spent":"503.299994ms","remote":"127.0.0.1:52034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:29:26.244318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.53564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:29:26.244369Z","caller":"traceutil/trace.go:171","msg":"trace[1680496588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"481.607701ms","start":"2026-07-30T19:29:25.76275Z","end":"2026-07-30T19:29:26.244357Z","steps":["trace[1680496588] 'agreement among raft nodes before linearized reading' (duration: 481.511999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:29:26.244407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:29:25.762716Z","time spent":"481.681473ms","remote":"127.0.0.1:51606","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-07-30T19:29:26.244561Z","caller":"traceutil/trace.go:171","msg":"trace[1716898637] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"193.129918ms","start":"2026-07-30T19:29:26.051396Z","end":"2026-07-30T19:29:26.244526Z","steps":["trace[1716898637] 'process raft request' (duration: 192.727807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.698753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.428365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-30T19:30:01.698842Z","caller":"traceutil/trace.go:171","msg":"trace[530966930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1009; }","duration":"549.565569ms","start":"2026-07-30T19:30:01.149258Z","end":"2026-07-30T19:30:01.698824Z","steps":["trace[530966930] 'range keys from in-memory index tree' (duration: 549.27143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.698878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.149235Z","time spent":"549.635281ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-30T19:30:01.698869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.162228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:30:01.698942Z","caller":"traceutil/trace.go:171","msg":"trace[1590145747] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"539.226417ms","start":"2026-07-30T19:30:01.159703Z","end":"2026-07-30T19:30:01.698929Z","steps":["trace[1590145747] 'read index received' (duration: 56.889254ms)","trace[1590145747] 'applied index is now lower than readState.Index' (duration: 482.336443ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:01.6991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.91585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:01.699089Z","caller":"traceutil/trace.go:171","msg":"trace[211599230] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"546.30687ms","start":"2026-07-30T19:30:01.152755Z","end":"2026-07-30T19:30:01.699062Z","steps":["trace[211599230] 'process raft request' (duration: 63.891415ms)","trace[211599230] 'compare' (duration: 482.088646ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:30:01.699125Z","caller":"traceutil/trace.go:171","msg":"trace[1791154287] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1010; }","duration":"169.967042ms","start":"2026-07-30T19:30:01.529151Z","end":"2026-07-30T19:30:01.699118Z","steps":["trace[1791154287] 'agreement among raft nodes before linearized reading' (duration: 169.923341ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.699129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.922684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-30T19:30:01.69916Z","caller":"traceutil/trace.go:171","msg":"trace[1991917852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1010; }","duration":"536.972715ms","start":"2026-07-30T19:30:01.162176Z","end":"2026-07-30T19:30:01.699149Z","steps":["trace[1991917852] 'agreement among raft nodes before linearized reading' (duration: 536.884292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.699202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.162166Z","time spent":"537.029206ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T19:30:01.699197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.637276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-30T19:30:01.699211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.152738Z","time spent":"546.407492ms","remote":"127.0.0.1:51854","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-07-30T19:30:01.69925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.873412ms","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-07-30T19:30:01.699273Z","caller":"traceutil/trace.go:171","msg":"trace[242832574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"536.943444ms","start":"2026-07-30T19:30:01.162323Z","end":"2026-07-30T19:30:01.699266Z","steps":["trace[242832574] 'agreement among raft nodes before linearized reading' (duration: 536.850161ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:01.699267Z","caller":"traceutil/trace.go:171","msg":"trace[236530957] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1010; }","duration":"469.731288ms","start":"2026-07-30T19:30:01.229515Z","end":"2026-07-30T19:30:01.699247Z","steps":["trace[236530957] 'agreement among raft nodes before linearized reading' (duration: 469.584854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.699294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.162293Z","time spent":"536.995325ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-30T19:30:01.699283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.545355ms","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-07-30T19:30:01.699316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.229504Z","time spent":"469.797921ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-30T19:30:01.699344Z","caller":"traceutil/trace.go:171","msg":"trace[148710828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"539.649768ms","start":"2026-07-30T19:30:01.159679Z","end":"2026-07-30T19:30:01.699329Z","steps":["trace[148710828] 'agreement among raft nodes before linearized reading' (duration: 539.433983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:01.69938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.159668Z","time spent":"539.70474ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-30T19:30:02.106775Z","caller":"traceutil/trace.go:171","msg":"trace[1904266834] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"404.369294ms","start":"2026-07-30T19:30:01.702385Z","end":"2026-07-30T19:30:02.106754Z","steps":["trace[1904266834] 'process raft request' (duration: 401.052323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:02.106884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.70236Z","time spent":"404.467356ms","remote":"127.0.0.1:51854","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-07-30T19:30:02.111415Z","caller":"traceutil/trace.go:171","msg":"trace[28838907] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"408.822305ms","start":"2026-07-30T19:30:01.702576Z","end":"2026-07-30T19:30:02.111398Z","steps":["trace[28838907] 'process raft request' (duration: 408.716872ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:02.111425Z","caller":"traceutil/trace.go:171","msg":"trace[1599995181] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"407.240501ms","start":"2026-07-30T19:30:01.70416Z","end":"2026-07-30T19:30:02.111401Z","steps":["trace[1599995181] 'process raft request' (duration: 407.164689ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:02.111492Z","caller":"traceutil/trace.go:171","msg":"trace[1497512514] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1046; }","duration":"349.605078ms","start":"2026-07-30T19:30:01.761877Z","end":"2026-07-30T19:30:02.111482Z","steps":["trace[1497512514] 'read index received' (duration: 341.568768ms)","trace[1497512514] 'applied index is now lower than readState.Index' (duration: 8.03503ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:02.111521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.702566Z","time spent":"408.896327ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:30:02.111561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.70415Z","time spent":"407.339575ms","remote":"127.0.0.1:51854","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-07-30T19:30:02.111626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.743891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:02.11167Z","caller":"traceutil/trace.go:171","msg":"trace[211337228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1015; }","duration":"349.804013ms","start":"2026-07-30T19:30:01.761849Z","end":"2026-07-30T19:30:02.111653Z","steps":["trace[211337228] 'agreement among raft nodes before linearized reading' (duration: 349.744142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:02.111694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.761835Z","time spent":"349.854344ms","remote":"127.0.0.1:51606","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-07-30T19:30:02.111416Z","caller":"traceutil/trace.go:171","msg":"trace[169652937] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"408.871956ms","start":"2026-07-30T19:30:01.702516Z","end":"2026-07-30T19:30:02.111388Z","steps":["trace[169652937] 'process raft request' (duration: 408.64366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:02.111741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:01.7025Z","time spent":"409.213916ms","remote":"127.0.0.1:51854","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-07-30T19:30:21.915341Z","caller":"traceutil/trace.go:171","msg":"trace[92625969] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"130.112313ms","start":"2026-07-30T19:30:21.785153Z","end":"2026-07-30T19:30:21.915266Z","steps":["trace[92625969] 'process raft request' (duration: 129.943019ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:23.576147Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700946183098679,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-30T19:30:23.785601Z","caller":"traceutil/trace.go:171","msg":"trace[84067982] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"852.120792ms","start":"2026-07-30T19:30:22.93345Z","end":"2026-07-30T19:30:23.78557Z","steps":["trace[84067982] 'process raft request' (duration: 851.915937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:23.785834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:22.933424Z","time spent":"852.271296ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:30:24.24592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.268751ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-30T19:30:24.246095Z","caller":"traceutil/trace.go:171","msg":"trace[1110838654] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1121; }","duration":"1.170595789s","start":"2026-07-30T19:30:23.07548Z","end":"2026-07-30T19:30:24.246075Z","steps":["trace[1110838654] 'read index received' (duration: 709.846326ms)","trace[1110838654] 'applied index is now lower than readState.Index' (duration: 460.747793ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:24.246228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170738694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:24.246257Z","caller":"traceutil/trace.go:171","msg":"trace[664776817] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1082; }","duration":"1.170814146s","start":"2026-07-30T19:30:23.075433Z","end":"2026-07-30T19:30:24.246247Z","steps":["trace[664776817] 'agreement among raft nodes before linearized reading' (duration: 1.170733204s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.246292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.075411Z","time spent":"1.170872147s","remote":"127.0.0.1:51796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:30:24.251562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.459214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:30:24.251599Z","caller":"traceutil/trace.go:171","msg":"trace[1462883211] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"329.460337ms","start":"2026-07-30T19:30:23.922118Z","end":"2026-07-30T19:30:24.251579Z","steps":["trace[1462883211] 'process raft request' (duration: 329.232941ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:24.251637Z","caller":"traceutil/trace.go:171","msg":"trace[179312427] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1083; }","duration":"799.589677ms","start":"2026-07-30T19:30:23.452026Z","end":"2026-07-30T19:30:24.251616Z","steps":["trace[179312427] 'agreement among raft nodes before linearized reading' (duration: 799.468174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.251681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.451997Z","time spent":"799.67504ms","remote":"127.0.0.1:52088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:30:24.251708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.922081Z","time spent":"329.56236ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:30:24.251716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.197088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-30T19:30:24.251775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.551431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:30:24.251801Z","caller":"traceutil/trace.go:171","msg":"trace[1190165261] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1083; }","duration":"252.346752ms","start":"2026-07-30T19:30:23.999433Z","end":"2026-07-30T19:30:24.251779Z","steps":["trace[1190165261] 'agreement among raft nodes before linearized reading' (duration: 252.078705ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:24.251816Z","caller":"traceutil/trace.go:171","msg":"trace[2036967122] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1083; }","duration":"626.644204ms","start":"2026-07-30T19:30:23.62516Z","end":"2026-07-30T19:30:24.251804Z","steps":["trace[2036967122] 'agreement among raft nodes before linearized reading' (duration: 626.576402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.251925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:24.252026Z","caller":"traceutil/trace.go:171","msg":"trace[554555569] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1083; }","duration":"143.705695ms","start":"2026-07-30T19:30:24.108293Z","end":"2026-07-30T19:30:24.251999Z","steps":["trace[554555569] 'agreement among raft nodes before linearized reading' (duration: 143.508759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.251988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.625128Z","time spent":"626.847549ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:30:24.252004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.268782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T19:30:24.25208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.389664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:24.252149Z","caller":"traceutil/trace.go:171","msg":"trace[1776943715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"489.484658ms","start":"2026-07-30T19:30:23.762636Z","end":"2026-07-30T19:30:24.252121Z","steps":["trace[1776943715] 'agreement among raft nodes before linearized reading' (duration: 489.215461ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:24.25219Z","caller":"traceutil/trace.go:171","msg":"trace[2066390457] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1083; }","duration":"605.570648ms","start":"2026-07-30T19:30:23.646594Z","end":"2026-07-30T19:30:24.252164Z","steps":["trace[2066390457] 'agreement among raft nodes before linearized reading' (duration: 605.020913ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.252213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.762615Z","time spent":"489.588811ms","remote":"127.0.0.1:51606","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-07-30T19:30:24.252267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:23.646563Z","time spent":"605.676181ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:30:24.782644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.382265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:30:24.783231Z","caller":"traceutil/trace.go:171","msg":"trace[1271995383] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1126; }","duration":"232.632544ms","start":"2026-07-30T19:30:24.55058Z","end":"2026-07-30T19:30:24.783212Z","steps":["trace[1271995383] 'read index received' (duration: 85.67481ms)","trace[1271995383] 'applied index is now lower than readState.Index' (duration: 146.956814ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:30:24.783438Z","caller":"traceutil/trace.go:171","msg":"trace[1001667066] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"439.222764ms","start":"2026-07-30T19:30:24.3442Z","end":"2026-07-30T19:30:24.783423Z","steps":["trace[1001667066] 'process raft request' (duration: 438.569017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:24.783599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.007493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:30:24.783716Z","caller":"traceutil/trace.go:171","msg":"trace[998251878] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1087; }","duration":"233.187539ms","start":"2026-07-30T19:30:24.55051Z","end":"2026-07-30T19:30:24.783698Z","steps":["trace[998251878] 'agreement among raft nodes before linearized reading' (duration: 232.921962ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:24.78375Z","caller":"traceutil/trace.go:171","msg":"trace[1749921185] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"439.610265ms","start":"2026-07-30T19:30:24.344088Z","end":"2026-07-30T19:30:24.783698Z","steps":["trace[1749921185] 'process raft request' (duration: 291.092229ms)","trace[1749921185] 'compare' (duration: 147.248851ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:24.783983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:24.344071Z","time spent":"439.78545ms","remote":"127.0.0.1:51854","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-07-30T19:30:24.784075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:24.344156Z","time spent":"439.43915ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:30:26.084735Z","caller":"traceutil/trace.go:171","msg":"trace[1510297117] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"290.906965ms","start":"2026-07-30T19:30:25.793782Z","end":"2026-07-30T19:30:26.084689Z","steps":["trace[1510297117] 'process raft request' (duration: 290.657688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.001558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.620018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:30:27.002273Z","caller":"traceutil/trace.go:171","msg":"trace[1012793417] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"686.764106ms","start":"2026-07-30T19:30:26.315483Z","end":"2026-07-30T19:30:27.002247Z","steps":["trace[1012793417] 'read index received' (duration: 269.243593ms)","trace[1012793417] 'applied index is now lower than readState.Index' (duration: 417.517683ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:30:27.002309Z","caller":"traceutil/trace.go:171","msg":"trace[251630885] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"743.6665ms","start":"2026-07-30T19:30:26.258594Z","end":"2026-07-30T19:30:27.002261Z","steps":["trace[251630885] 'process raft request' (duration: 326.201089ms)","trace[251630885] 'compare' (duration: 416.130045ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:27.002504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.011402ms","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-07-30T19:30:27.00287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.284525ms","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-07-30T19:30:27.002897Z","caller":"traceutil/trace.go:171","msg":"trace[2005138877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1089; }","duration":"687.447065ms","start":"2026-07-30T19:30:26.315429Z","end":"2026-07-30T19:30:27.002876Z","steps":["trace[2005138877] 'agreement among raft nodes before linearized reading' (duration: 686.90877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.002977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:26.315407Z","time spent":"687.542177ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-30T19:30:27.002995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.266922ms","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-07-30T19:30:27.003023Z","caller":"traceutil/trace.go:171","msg":"trace[1330078792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1089; }","duration":"214.321204ms","start":"2026-07-30T19:30:26.788695Z","end":"2026-07-30T19:30:27.003016Z","steps":["trace[1330078792] 'agreement among raft nodes before linearized reading' (duration: 214.17412ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:27.003005Z","caller":"traceutil/trace.go:171","msg":"trace[1731446015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1089; }","duration":"659.399079ms","start":"2026-07-30T19:30:26.343516Z","end":"2026-07-30T19:30:27.002915Z","steps":["trace[1731446015] 'agreement among raft nodes before linearized reading' (duration: 659.209664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.003055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.629951ms","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-07-30T19:30:27.003115Z","caller":"traceutil/trace.go:171","msg":"trace[897801562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1089; }","duration":"214.747075ms","start":"2026-07-30T19:30:26.788355Z","end":"2026-07-30T19:30:27.003102Z","steps":["trace[897801562] 'agreement among raft nodes before linearized reading' (duration: 214.594581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.003069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:26.343483Z","time spent":"659.565114ms","remote":"127.0.0.1:51854","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-07-30T19:30:27.00286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:26.258563Z","time spent":"744.200855ms","remote":"127.0.0.1:51854","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-07-30T19:30:27.398953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.665496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:30:27.399368Z","caller":"traceutil/trace.go:171","msg":"trace[2046977976] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"391.712268ms","start":"2026-07-30T19:30:27.00763Z","end":"2026-07-30T19:30:27.399342Z","steps":["trace[2046977976] 'process raft request' (duration: 391.459481ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.399491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:27.007614Z","time spent":"391.821411ms","remote":"127.0.0.1:51854","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-07-30T19:30:27.399524Z","caller":"traceutil/trace.go:171","msg":"trace[492520830] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1130; }","duration":"207.212719ms","start":"2026-07-30T19:30:27.192288Z","end":"2026-07-30T19:30:27.399501Z","steps":["trace[492520830] 'read index received' (duration: 191.898971ms)","trace[492520830] 'applied index is now lower than readState.Index' (duration: 15.312218ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:27.399662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.349863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:27.399705Z","caller":"traceutil/trace.go:171","msg":"trace[1399179497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1093; }","duration":"207.413684ms","start":"2026-07-30T19:30:27.19228Z","end":"2026-07-30T19:30:27.399694Z","steps":["trace[1399179497] 'agreement among raft nodes before linearized reading' (duration: 207.315182ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:27.399722Z","caller":"traceutil/trace.go:171","msg":"trace[378903200] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"391.999146ms","start":"2026-07-30T19:30:27.007705Z","end":"2026-07-30T19:30:27.399704Z","steps":["trace[378903200] 'process raft request' (duration: 391.582324ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:27.399404Z","caller":"traceutil/trace.go:171","msg":"trace[1940919393] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"392.309884ms","start":"2026-07-30T19:30:27.006996Z","end":"2026-07-30T19:30:27.399306Z","steps":["trace[1940919393] 'process raft request' (duration: 152.144955ms)","trace[1940919393] 'compare' (duration: 239.313125ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:30:27.399884Z","caller":"traceutil/trace.go:171","msg":"trace[372356351] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"391.997976ms","start":"2026-07-30T19:30:27.007871Z","end":"2026-07-30T19:30:27.399869Z","steps":["trace[372356351] 'process raft request' (duration: 391.536353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:27.400045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:27.007858Z","time spent":"392.13998ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:30:27.400248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:27.006967Z","time spent":"392.968062ms","remote":"127.0.0.1:51854","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-07-30T19:30:27.399817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:27.007656Z","time spent":"392.118638ms","remote":"127.0.0.1:51854","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-07-30T19:30:41.250532Z","caller":"traceutil/trace.go:171","msg":"trace[569348743] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"202.83017ms","start":"2026-07-30T19:30:41.047676Z","end":"2026-07-30T19:30:41.250506Z","steps":["trace[569348743] 'process raft request' (duration: 202.672856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:42.913312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700946183098932,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T19:30:43.413634Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700946183098932,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T19:30:43.737292Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.582233441s","expected-duration":"1s"} {"level":"info","ts":"2026-07-30T19:30:43.737594Z","caller":"traceutil/trace.go:171","msg":"trace[1668293257] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"1.583412893s","start":"2026-07-30T19:30:42.154163Z","end":"2026-07-30T19:30:43.737576Z","steps":["trace[1668293257] 'process raft request' (duration: 1.58330151s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.737707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:42.154138Z","time spent":"1.583506626s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:30:43.779204Z","caller":"traceutil/trace.go:171","msg":"trace[1338603947] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"522.790048ms","start":"2026-07-30T19:30:43.256383Z","end":"2026-07-30T19:30:43.779173Z","steps":["trace[1338603947] 'process raft request' (duration: 522.441248ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:43.779312Z","caller":"traceutil/trace.go:171","msg":"trace[1251692634] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"488.890551ms","start":"2026-07-30T19:30:43.290367Z","end":"2026-07-30T19:30:43.779257Z","steps":["trace[1251692634] 'process raft request' (duration: 488.697266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.779382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.256355Z","time spent":"522.925561ms","remote":"127.0.0.1:51854","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-07-30T19:30:43.779466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.290337Z","time spent":"489.050886ms","remote":"127.0.0.1:51854","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-07-30T19:30:43.788963Z","caller":"traceutil/trace.go:171","msg":"trace[566130611] linearizableReadLoop","detail":"{readStateIndex:1241; appliedIndex:1237; }","duration":"1.376053431s","start":"2026-07-30T19:30:42.412887Z","end":"2026-07-30T19:30:43.788941Z","steps":["trace[566130611] 'read index received' (duration: 1.324567775s)","trace[566130611] 'applied index is now lower than readState.Index' (duration: 51.484786ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:43.789113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028290273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:43.789132Z","caller":"traceutil/trace.go:171","msg":"trace[924173162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1194; }","duration":"1.028356265s","start":"2026-07-30T19:30:42.760769Z","end":"2026-07-30T19:30:43.789125Z","steps":["trace[924173162] 'agreement among raft nodes before linearized reading' (duration: 1.028287593s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.78911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376203624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T19:30:43.789153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:42.760748Z","time spent":"1.028400337s","remote":"127.0.0.1:51592","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-07-30T19:30:43.789184Z","caller":"traceutil/trace.go:171","msg":"trace[1421445287] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1194; }","duration":"1.376350879s","start":"2026-07-30T19:30:42.412812Z","end":"2026-07-30T19:30:43.789163Z","steps":["trace[1421445287] 'agreement among raft nodes before linearized reading' (duration: 1.376217225s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.789211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.909189ms","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-07-30T19:30:43.789257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:42.41278Z","time spent":"1.376464812s","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-30T19:30:43.789262Z","caller":"traceutil/trace.go:171","msg":"trace[1849005962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1194; }","duration":"308.003372ms","start":"2026-07-30T19:30:43.481243Z","end":"2026-07-30T19:30:43.789246Z","steps":["trace[1849005962] 'agreement among raft nodes before linearized reading' (duration: 307.839308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.789277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.3916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-30T19:30:43.789299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.481223Z","time spent":"308.068613ms","remote":"127.0.0.1:51854","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-07-30T19:30:43.789304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.7949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:30:43.789328Z","caller":"traceutil/trace.go:171","msg":"trace[366382492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1194; }","duration":"313.486452ms","start":"2026-07-30T19:30:43.475827Z","end":"2026-07-30T19:30:43.789314Z","steps":["trace[366382492] 'agreement among raft nodes before linearized reading' (duration: 313.321768ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:43.78937Z","caller":"traceutil/trace.go:171","msg":"trace[1727095444] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1194; }","duration":"956.921564ms","start":"2026-07-30T19:30:42.832433Z","end":"2026-07-30T19:30:43.789355Z","steps":["trace[1727095444] 'agreement among raft nodes before linearized reading' (duration: 956.7673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.789375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.475806Z","time spent":"313.556643ms","remote":"127.0.0.1:51854","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-07-30T19:30:43.789365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.122955ms","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-07-30T19:30:43.789406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:42.832416Z","time spent":"956.983295ms","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:30:43.789438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.948417ms","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-07-30T19:30:43.789454Z","caller":"traceutil/trace.go:171","msg":"trace[724452435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1194; }","duration":"304.250499ms","start":"2026-07-30T19:30:43.485182Z","end":"2026-07-30T19:30:43.789433Z","steps":["trace[724452435] 'agreement among raft nodes before linearized reading' (duration: 303.974382ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:30:43.789468Z","caller":"traceutil/trace.go:171","msg":"trace[791036045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"313.012059ms","start":"2026-07-30T19:30:43.476447Z","end":"2026-07-30T19:30:43.789459Z","steps":["trace[791036045] 'agreement among raft nodes before linearized reading' (duration: 312.934397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:43.789498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.476427Z","time spent":"313.0631ms","remote":"127.0.0.1:51854","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-07-30T19:30:43.789497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:30:43.485172Z","time spent":"304.317581ms","remote":"127.0.0.1:51854","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-07-30T19:30:58.021794Z","caller":"traceutil/trace.go:171","msg":"trace[208841598] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1294; }","duration":"161.502912ms","start":"2026-07-30T19:30:57.860154Z","end":"2026-07-30T19:30:58.021657Z","steps":["trace[208841598] 'read index received' (duration: 32.22755ms)","trace[208841598] 'applied index is now lower than readState.Index' (duration: 129.273982ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:30:58.021869Z","caller":"traceutil/trace.go:171","msg":"trace[1625738018] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"174.481126ms","start":"2026-07-30T19:30:57.847343Z","end":"2026-07-30T19:30:58.021824Z","steps":["trace[1625738018] 'process raft request' (duration: 117.190821ms)","trace[1625738018] 'compare' (duration: 56.902285ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:30:58.022037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.83434ms","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-07-30T19:30:58.022188Z","caller":"traceutil/trace.go:171","msg":"trace[73025474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1247; }","duration":"162.039526ms","start":"2026-07-30T19:30:57.860121Z","end":"2026-07-30T19:30:58.02216Z","steps":["trace[73025474] 'agreement among raft nodes before linearized reading' (duration: 161.546193ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:58.02245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.249921ms","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-07-30T19:30:58.022487Z","caller":"traceutil/trace.go:171","msg":"trace[591068439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1247; }","duration":"129.315032ms","start":"2026-07-30T19:30:57.893159Z","end":"2026-07-30T19:30:58.022474Z","steps":["trace[591068439] 'agreement among raft nodes before linearized reading' (duration: 129.215729ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:58.022516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.854572ms","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-07-30T19:30:58.022602Z","caller":"traceutil/trace.go:171","msg":"trace[754531531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1247; }","duration":"127.979296ms","start":"2026-07-30T19:30:57.894609Z","end":"2026-07-30T19:30:58.022588Z","steps":["trace[754531531] 'agreement among raft nodes before linearized reading' (duration: 127.76352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:30:58.022741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.647184ms","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-07-30T19:30:58.02282Z","caller":"traceutil/trace.go:171","msg":"trace[1754951826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"158.958692ms","start":"2026-07-30T19:30:57.863843Z","end":"2026-07-30T19:30:58.022802Z","steps":["trace[1754951826] 'agreement among raft nodes before linearized reading' (duration: 158.51825ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:00.403038Z","caller":"traceutil/trace.go:171","msg":"trace[1975957915] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"281.429067ms","start":"2026-07-30T19:31:00.121582Z","end":"2026-07-30T19:31:00.403011Z","steps":["trace[1975957915] 'read index received' (duration: 281.147279ms)","trace[1975957915] 'applied index is now lower than readState.Index' (duration: 280.878µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:31:00.403365Z","caller":"traceutil/trace.go:171","msg":"trace[848331639] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"375.186448ms","start":"2026-07-30T19:31:00.028164Z","end":"2026-07-30T19:31:00.40335Z","steps":["trace[848331639] 'process raft request' (duration: 374.639993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:00.403489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.028145Z","time spent":"375.26231ms","remote":"127.0.0.1:51854","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-07-30T19:31:00.403793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.209588ms","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-07-30T19:31:00.403835Z","caller":"traceutil/trace.go:171","msg":"trace[2111467253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1267; }","duration":"282.29273ms","start":"2026-07-30T19:31:00.121532Z","end":"2026-07-30T19:31:00.403825Z","steps":["trace[2111467253] 'agreement among raft nodes before linearized reading' (duration: 282.160927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:00.404021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.878049ms","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-07-30T19:31:00.404058Z","caller":"traceutil/trace.go:171","msg":"trace[421832299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1267; }","duration":"281.93304ms","start":"2026-07-30T19:31:00.122116Z","end":"2026-07-30T19:31:00.404049Z","steps":["trace[421832299] 'agreement among raft nodes before linearized reading' (duration: 281.844358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:00.404314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.906019ms","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-07-30T19:31:00.404353Z","caller":"traceutil/trace.go:171","msg":"trace[1330300832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1267; }","duration":"281.965511ms","start":"2026-07-30T19:31:00.122378Z","end":"2026-07-30T19:31:00.404343Z","steps":["trace[1330300832] 'agreement among raft nodes before linearized reading' (duration: 281.872039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:00.404547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.334642ms","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-07-30T19:31:00.404585Z","caller":"traceutil/trace.go:171","msg":"trace[230643083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1267; }","duration":"282.395813ms","start":"2026-07-30T19:31:00.122181Z","end":"2026-07-30T19:31:00.404577Z","steps":["trace[230643083] 'agreement among raft nodes before linearized reading' (duration: 282.30759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:01.244834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.75653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:31:01.245123Z","caller":"traceutil/trace.go:171","msg":"trace[2112897298] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"834.65207ms","start":"2026-07-30T19:31:00.410432Z","end":"2026-07-30T19:31:01.245084Z","steps":["trace[2112897298] 'process raft request' (duration: 307.545851ms)","trace[2112897298] 'compare' (duration: 525.897426ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:31:01.245184Z","caller":"traceutil/trace.go:171","msg":"trace[1784865860] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1317; }","duration":"480.97384ms","start":"2026-07-30T19:31:00.764192Z","end":"2026-07-30T19:31:01.245165Z","steps":["trace[1784865860] 'read index received' (duration: 467.393418ms)","trace[1784865860] 'applied index is now lower than readState.Index' (duration: 13.579012ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:31:01.245258Z","caller":"traceutil/trace.go:171","msg":"trace[944671309] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"832.689387ms","start":"2026-07-30T19:31:00.412522Z","end":"2026-07-30T19:31:01.245211Z","steps":["trace[944671309] 'process raft request' (duration: 832.42855ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:01.245283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.4104Z","time spent":"834.794004ms","remote":"127.0.0.1:51854","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-07-30T19:31:01.245338Z","caller":"traceutil/trace.go:171","msg":"trace[1433870352] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"832.629005ms","start":"2026-07-30T19:31:00.412696Z","end":"2026-07-30T19:31:01.245325Z","steps":["trace[1433870352] 'process raft request' (duration: 832.426149ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:01.245361Z","caller":"traceutil/trace.go:171","msg":"trace[976663811] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"832.743919ms","start":"2026-07-30T19:31:00.412571Z","end":"2026-07-30T19:31:01.245315Z","steps":["trace[976663811] 'process raft request' (duration: 832.500012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:01.245407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.412662Z","time spent":"832.712527ms","remote":"127.0.0.1:51854","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-07-30T19:31:01.245438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.412506Z","time spent":"832.833591ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:31:01.245295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.113313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:01.245541Z","caller":"traceutil/trace.go:171","msg":"trace[1031134677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1271; }","duration":"481.415311ms","start":"2026-07-30T19:31:00.764111Z","end":"2026-07-30T19:31:01.245526Z","steps":["trace[1031134677] 'agreement among raft nodes before linearized reading' (duration: 481.118073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:01.245557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.412568Z","time spent":"832.887833ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:31:01.245585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:00.764076Z","time spent":"481.498304ms","remote":"127.0.0.1:51606","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-07-30T19:31:02.58355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.082027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:31:02.583634Z","caller":"traceutil/trace.go:171","msg":"trace[1264730418] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1273; }","duration":"386.21271ms","start":"2026-07-30T19:31:02.197407Z","end":"2026-07-30T19:31:02.58362Z","steps":["trace[1264730418] 'count revisions from in-memory index tree' (duration: 386.006124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:02.583662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:02.197391Z","time spent":"386.264401ms","remote":"127.0.0.1:51782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:31:02.583886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.784728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:02.58391Z","caller":"traceutil/trace.go:171","msg":"trace[136286607] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1273; }","duration":"210.835719ms","start":"2026-07-30T19:31:02.373064Z","end":"2026-07-30T19:31:02.583899Z","steps":["trace[136286607] 'count revisions from in-memory index tree' (duration: 210.672926ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:02.58818Z","caller":"traceutil/trace.go:171","msg":"trace[816012207] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"176.818081ms","start":"2026-07-30T19:31:02.411339Z","end":"2026-07-30T19:31:02.588157Z","steps":["trace[816012207] 'process raft request' (duration: 176.681017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:03.411203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.67532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:03.412028Z","caller":"traceutil/trace.go:171","msg":"trace[444451487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1274; }","duration":"649.546174ms","start":"2026-07-30T19:31:02.762455Z","end":"2026-07-30T19:31:03.412001Z","steps":["trace[444451487] 'range keys from in-memory index tree' (duration: 648.580677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:03.412178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:02.762432Z","time spent":"649.727209ms","remote":"127.0.0.1:51606","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-07-30T19:31:03.41148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.085741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-30T19:31:03.412007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.443681ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:03.412435Z","caller":"traceutil/trace.go:171","msg":"trace[379609858] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1274; }","duration":"430.761767ms","start":"2026-07-30T19:31:02.981655Z","end":"2026-07-30T19:31:03.412416Z","steps":["trace[379609858] 'range keys from in-memory index tree' (duration: 429.428131ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:03.412372Z","caller":"traceutil/trace.go:171","msg":"trace[776497321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1274; }","duration":"162.007466ms","start":"2026-07-30T19:31:03.250336Z","end":"2026-07-30T19:31:03.412343Z","steps":["trace[776497321] 'range keys from in-memory index tree' (duration: 160.935767ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:03.41159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.760342ms","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-07-30T19:31:03.412587Z","caller":"traceutil/trace.go:171","msg":"trace[669862591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"161.77939ms","start":"2026-07-30T19:31:03.250783Z","end":"2026-07-30T19:31:03.412562Z","steps":["trace[669862591] 'range keys from in-memory index tree' (duration: 160.555146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:03.41169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.324087ms","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-07-30T19:31:03.4118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.345938ms","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-07-30T19:31:03.412805Z","caller":"traceutil/trace.go:171","msg":"trace[1170235596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1274; }","duration":"162.373025ms","start":"2026-07-30T19:31:03.250421Z","end":"2026-07-30T19:31:03.412794Z","steps":["trace[1170235596] 'range keys from in-memory index tree' (duration: 161.200264ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:03.412771Z","caller":"traceutil/trace.go:171","msg":"trace[2080925605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"162.394346ms","start":"2026-07-30T19:31:03.250319Z","end":"2026-07-30T19:31:03.412714Z","steps":["trace[2080925605] 'range keys from in-memory index tree' (duration: 161.185604ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:03.774218Z","caller":"traceutil/trace.go:171","msg":"trace[1892833560] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"120.645415ms","start":"2026-07-30T19:31:03.653556Z","end":"2026-07-30T19:31:03.774202Z","steps":["trace[1892833560] 'process raft request' (duration: 120.562773ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:03.847817Z","caller":"traceutil/trace.go:171","msg":"trace[365152774] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"165.45425ms","start":"2026-07-30T19:31:03.682318Z","end":"2026-07-30T19:31:03.847773Z","steps":["trace[365152774] 'process raft request' (duration: 126.762663ms)","trace[365152774] 'compare' (duration: 38.560343ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:31:04.279953Z","caller":"traceutil/trace.go:171","msg":"trace[1532622397] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"312.410614ms","start":"2026-07-30T19:31:03.967516Z","end":"2026-07-30T19:31:04.279926Z","steps":["trace[1532622397] 'process raft request' (duration: 312.25493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:04.280112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:03.967496Z","time spent":"312.533828ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:31:04.653487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.546793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:31:04.653594Z","caller":"traceutil/trace.go:171","msg":"trace[1540091723] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"399.107972ms","start":"2026-07-30T19:31:04.254463Z","end":"2026-07-30T19:31:04.653571Z","steps":["trace[1540091723] 'process raft request' (duration: 200.392184ms)","trace[1540091723] 'compare' (duration: 198.168873ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:31:04.653651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:04.254438Z","time spent":"399.186845ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:31:09.020855Z","caller":"traceutil/trace.go:171","msg":"trace[1921071221] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"131.550683ms","start":"2026-07-30T19:31:08.889283Z","end":"2026-07-30T19:31:09.020834Z","steps":["trace[1921071221] 'process raft request' (duration: 131.280766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:14.822391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.115057ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-30T19:31:14.822548Z","caller":"traceutil/trace.go:171","msg":"trace[1421357362] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1403; }","duration":"1.338322828s","start":"2026-07-30T19:31:13.4842Z","end":"2026-07-30T19:31:14.822523Z","steps":["trace[1421357362] 'read index received' (duration: 433.961484ms)","trace[1421357362] 'applied index is now lower than readState.Index' (duration: 904.359574ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:31:14.822806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338594966s","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-07-30T19:31:14.822893Z","caller":"traceutil/trace.go:171","msg":"trace[1254267602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1351; }","duration":"1.338729419s","start":"2026-07-30T19:31:13.484144Z","end":"2026-07-30T19:31:14.822873Z","steps":["trace[1254267602] 'agreement among raft nodes before linearized reading' (duration: 1.338508293s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:14.822935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.484122Z","time spent":"1.338804792s","remote":"127.0.0.1:51854","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-07-30T19:31:15.108246Z","caller":"traceutil/trace.go:171","msg":"trace[176754567] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1404; }","duration":"285.634163ms","start":"2026-07-30T19:31:14.822586Z","end":"2026-07-30T19:31:15.10822Z","steps":["trace[176754567] 'read index received' (duration: 285.479379ms)","trace[176754567] 'applied index is now lower than readState.Index' (duration: 153.604µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:31:15.10841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.289026132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-30T19:31:15.10847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.560365185s","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-07-30T19:31:15.108519Z","caller":"traceutil/trace.go:171","msg":"trace[68095007] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1352; }","duration":"1.289189266s","start":"2026-07-30T19:31:13.819306Z","end":"2026-07-30T19:31:15.108495Z","steps":["trace[68095007] 'agreement among raft nodes before linearized reading' (duration: 1.288946359s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:15.108508Z","caller":"traceutil/trace.go:171","msg":"trace[1006254366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1352; }","duration":"1.560442086s","start":"2026-07-30T19:31:13.548056Z","end":"2026-07-30T19:31:15.108498Z","steps":["trace[1006254366] 'agreement among raft nodes before linearized reading' (duration: 1.560286582s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.108599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.819293Z","time spent":"1.289284539s","remote":"127.0.0.1:51746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:31:15.108626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.548043Z","time spent":"1.56057078s","remote":"127.0.0.1:51854","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-07-30T19:31:15.108645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363045394s","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-07-30T19:31:15.108714Z","caller":"traceutil/trace.go:171","msg":"trace[179951918] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1352; }","duration":"1.363158537s","start":"2026-07-30T19:31:13.745536Z","end":"2026-07-30T19:31:15.108695Z","steps":["trace[179951918] 'agreement among raft nodes before linearized reading' (duration: 1.362944811s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.108701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573295357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-30T19:31:15.108761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.745514Z","time spent":"1.363236189s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-30T19:31:15.108754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.986491ms","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-07-30T19:31:15.108779Z","caller":"traceutil/trace.go:171","msg":"trace[1251686722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1352; }","duration":"1.573433961s","start":"2026-07-30T19:31:13.535326Z","end":"2026-07-30T19:31:15.10876Z","steps":["trace[1251686722] 'agreement among raft nodes before linearized reading' (duration: 1.573084542s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:15.10881Z","caller":"traceutil/trace.go:171","msg":"trace[883885185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1352; }","duration":"782.099074ms","start":"2026-07-30T19:31:14.326698Z","end":"2026-07-30T19:31:15.108797Z","steps":["trace[883885185] 'agreement among raft nodes before linearized reading' (duration: 781.94209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.108824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.535299Z","time spent":"1.573516614s","remote":"127.0.0.1:51854","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-07-30T19:31:15.108853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:14.32666Z","time spent":"782.185796ms","remote":"127.0.0.1:51854","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-07-30T19:31:15.108845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561283759s","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-07-30T19:31:15.108987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219367149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T19:31:15.109029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084206587s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-30T19:31:15.109046Z","caller":"traceutil/trace.go:171","msg":"trace[1418938551] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1352; }","duration":"1.219450381s","start":"2026-07-30T19:31:13.88958Z","end":"2026-07-30T19:31:15.10903Z","steps":["trace[1418938551] 'agreement among raft nodes before linearized reading' (duration: 1.219372299s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:15.109069Z","caller":"traceutil/trace.go:171","msg":"trace[1545920102] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1352; }","duration":"1.084253108s","start":"2026-07-30T19:31:14.024806Z","end":"2026-07-30T19:31:15.109059Z","steps":["trace[1545920102] 'agreement among raft nodes before linearized reading' (duration: 1.084136375s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.10908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.889566Z","time spent":"1.219505093s","remote":"127.0.0.1:60358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-07-30T19:31:15.109082Z","caller":"traceutil/trace.go:171","msg":"trace[1631118939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1352; }","duration":"1.561496295s","start":"2026-07-30T19:31:13.547485Z","end":"2026-07-30T19:31:15.108981Z","steps":["trace[1631118939] 'agreement among raft nodes before linearized reading' (duration: 1.560889709s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.109098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:14.024791Z","time spent":"1.084298629s","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-30T19:31:15.109149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.547472Z","time spent":"1.561666509s","remote":"127.0.0.1:51854","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-07-30T19:31:15.109205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.884776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-07-30T19:31:15.108404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346296466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:15.109252Z","caller":"traceutil/trace.go:171","msg":"trace[344413316] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1352; }","duration":"484.965768ms","start":"2026-07-30T19:31:14.624273Z","end":"2026-07-30T19:31:15.109239Z","steps":["trace[344413316] 'agreement among raft nodes before linearized reading' (duration: 484.857335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.109286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:14.624252Z","time spent":"485.026949ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-30T19:31:15.109284Z","caller":"traceutil/trace.go:171","msg":"trace[2043816838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1352; }","duration":"1.347243982s","start":"2026-07-30T19:31:13.762028Z","end":"2026-07-30T19:31:15.109272Z","steps":["trace[2043816838] 'agreement among raft nodes before linearized reading' (duration: 1.346316887s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.109325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.762013Z","time spent":"1.347302553s","remote":"127.0.0.1:51606","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-07-30T19:31:15.108919Z","caller":"traceutil/trace.go:171","msg":"trace[1268372550] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"404.555871ms","start":"2026-07-30T19:31:14.704351Z","end":"2026-07-30T19:31:15.108907Z","steps":["trace[1268372550] 'process raft request' (duration: 403.687157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.109445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:14.704315Z","time spent":"405.053105ms","remote":"127.0.0.1:51854","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-07-30T19:31:15.110591Z","caller":"traceutil/trace.go:171","msg":"trace[585863759] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"280.842062ms","start":"2026-07-30T19:31:14.829712Z","end":"2026-07-30T19:31:15.110554Z","steps":["trace[585863759] 'process raft request' (duration: 280.588025ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:15.110588Z","caller":"traceutil/trace.go:171","msg":"trace[1058884340] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"241.284891ms","start":"2026-07-30T19:31:14.869284Z","end":"2026-07-30T19:31:15.110569Z","steps":["trace[1058884340] 'process raft request' (duration: 241.166628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.11225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477248353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:31:15.112331Z","caller":"traceutil/trace.go:171","msg":"trace[1790897037] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1354; }","duration":"1.477344406s","start":"2026-07-30T19:31:13.634959Z","end":"2026-07-30T19:31:15.112303Z","steps":["trace[1790897037] 'agreement among raft nodes before linearized reading' (duration: 1.477014807s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:31:15.112365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:31:13.634945Z","time spent":"1.477410548s","remote":"127.0.0.1:51944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-07-30T19:34:10.238816Z","caller":"traceutil/trace.go:171","msg":"trace[2030854229] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"126.087323ms","start":"2026-07-30T19:34:10.112671Z","end":"2026-07-30T19:34:10.238758Z","steps":["trace[2030854229] 'process raft request' (duration: 37.837213ms)","trace[2030854229] 'compare' (duration: 88.036984ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:10.377969Z","caller":"traceutil/trace.go:171","msg":"trace[1185344782] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"132.906539ms","start":"2026-07-30T19:34:10.245024Z","end":"2026-07-30T19:34:10.377931Z","steps":["trace[1185344782] 'process raft request' (duration: 132.837427ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:10.378128Z","caller":"traceutil/trace.go:171","msg":"trace[125644328] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"133.70723ms","start":"2026-07-30T19:34:10.244392Z","end":"2026-07-30T19:34:10.378099Z","steps":["trace[125644328] 'process raft request' (duration: 132.988341ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:14.608476Z","caller":"traceutil/trace.go:171","msg":"trace[915118594] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"118.127375ms","start":"2026-07-30T19:34:14.490317Z","end":"2026-07-30T19:34:14.608444Z","steps":["trace[915118594] 'process raft request' (duration: 28.94727ms)","trace[915118594] 'compare' (duration: 88.741793ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:15.710337Z","caller":"traceutil/trace.go:171","msg":"trace[24276108] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"128.425807ms","start":"2026-07-30T19:34:15.581886Z","end":"2026-07-30T19:34:15.710312Z","steps":["trace[24276108] 'process raft request' (duration: 36.187578ms)","trace[24276108] 'compare' (duration: 92.146316ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:18.534129Z","caller":"traceutil/trace.go:171","msg":"trace[1178873563] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"118.583817ms","start":"2026-07-30T19:34:18.415522Z","end":"2026-07-30T19:34:18.534106Z","steps":["trace[1178873563] 'process raft request' (duration: 118.366081ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:18.537926Z","caller":"traceutil/trace.go:171","msg":"trace[672194077] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"122.031092ms","start":"2026-07-30T19:34:18.415879Z","end":"2026-07-30T19:34:18.53791Z","steps":["trace[672194077] 'process raft request' (duration: 121.822416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:18.768828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.767607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:34:18.769032Z","caller":"traceutil/trace.go:171","msg":"trace[1947345603] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"153.403428ms","start":"2026-07-30T19:34:18.615606Z","end":"2026-07-30T19:34:18.769009Z","steps":["trace[1947345603] 'process raft request' (duration: 153.340846ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:18.769225Z","caller":"traceutil/trace.go:171","msg":"trace[923408648] linearizableReadLoop","detail":"{readStateIndex:2288; appliedIndex:2286; }","duration":"221.809626ms","start":"2026-07-30T19:34:18.547323Z","end":"2026-07-30T19:34:18.769132Z","steps":["trace[923408648] 'read index received' (duration: 29.111245ms)","trace[923408648] 'applied index is now lower than readState.Index' (duration: 192.695321ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:18.769429Z","caller":"traceutil/trace.go:171","msg":"trace[1790052938] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"226.273868ms","start":"2026-07-30T19:34:18.543133Z","end":"2026-07-30T19:34:18.769407Z","steps":["trace[1790052938] 'process raft request' (duration: 104.807701ms)","trace[1790052938] 'compare' (duration: 120.645784ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:18.769738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.418682ms","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-07-30T19:34:18.769793Z","caller":"traceutil/trace.go:171","msg":"trace[1698605322] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2199; }","duration":"222.489685ms","start":"2026-07-30T19:34:18.54729Z","end":"2026-07-30T19:34:18.76978Z","steps":["trace[1698605322] 'agreement among raft nodes before linearized reading' (duration: 222.379232ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:18.930848Z","caller":"traceutil/trace.go:171","msg":"trace[671529153] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"150.620242ms","start":"2026-07-30T19:34:18.780186Z","end":"2026-07-30T19:34:18.930806Z","steps":["trace[671529153] 'process raft request' (duration: 127.341547ms)","trace[671529153] 'compare' (duration: 23.101821ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:20.849392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.09728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-30T19:34:20.849493Z","caller":"traceutil/trace.go:171","msg":"trace[428581762] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2206; }","duration":"134.253634ms","start":"2026-07-30T19:34:20.715217Z","end":"2026-07-30T19:34:20.84947Z","steps":["trace[428581762] 'range keys from in-memory index tree' (duration: 133.941476ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:21.02636Z","caller":"traceutil/trace.go:171","msg":"trace[489781797] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"171.905263ms","start":"2026-07-30T19:34:20.854404Z","end":"2026-07-30T19:34:21.02631Z","steps":["trace[489781797] 'process raft request' (duration: 171.80202ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:21.026358Z","caller":"traceutil/trace.go:171","msg":"trace[676108246] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"172.16492ms","start":"2026-07-30T19:34:20.854144Z","end":"2026-07-30T19:34:21.026309Z","steps":["trace[676108246] 'process raft request' (duration: 124.251482ms)","trace[676108246] 'compare' (duration: 47.59116ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:27.190185Z","caller":"traceutil/trace.go:171","msg":"trace[726885148] linearizableReadLoop","detail":"{readStateIndex:2326; appliedIndex:2325; }","duration":"135.024487ms","start":"2026-07-30T19:34:27.055127Z","end":"2026-07-30T19:34:27.190152Z","steps":["trace[726885148] 'read index received' (duration: 134.829772ms)","trace[726885148] 'applied index is now lower than readState.Index' (duration: 193.585µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:27.190217Z","caller":"traceutil/trace.go:171","msg":"trace[1446924859] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"153.803379ms","start":"2026-07-30T19:34:27.036386Z","end":"2026-07-30T19:34:27.190189Z","steps":["trace[1446924859] 'process raft request' (duration: 153.536442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:27.190438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.287214ms","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-07-30T19:34:27.190529Z","caller":"traceutil/trace.go:171","msg":"trace[931483516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2235; }","duration":"135.413988ms","start":"2026-07-30T19:34:27.055095Z","end":"2026-07-30T19:34:27.190509Z","steps":["trace[931483516] 'agreement among raft nodes before linearized reading' (duration: 135.152431ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:27.318985Z","caller":"traceutil/trace.go:171","msg":"trace[903940060] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"102.437446ms","start":"2026-07-30T19:34:27.216511Z","end":"2026-07-30T19:34:27.318948Z","steps":["trace[903940060] 'read index received' (duration: 57.802307ms)","trace[903940060] 'applied index is now lower than readState.Index' (duration: 44.633079ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:27.319252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.713215ms","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-07-30T19:34:27.319294Z","caller":"traceutil/trace.go:171","msg":"trace[2031516346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2236; }","duration":"102.801987ms","start":"2026-07-30T19:34:27.21648Z","end":"2026-07-30T19:34:27.319282Z","steps":["trace[2031516346] 'agreement among raft nodes before linearized reading' (duration: 102.584081ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:27.319415Z","caller":"traceutil/trace.go:171","msg":"trace[1913668405] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"123.921754ms","start":"2026-07-30T19:34:27.195443Z","end":"2026-07-30T19:34:27.319364Z","steps":["trace[1913668405] 'process raft request' (duration: 78.983797ms)","trace[1913668405] 'compare' (duration: 44.091204ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:28.666074Z","caller":"traceutil/trace.go:171","msg":"trace[1625042638] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"111.286289ms","start":"2026-07-30T19:34:28.554728Z","end":"2026-07-30T19:34:28.666014Z","steps":["trace[1625042638] 'process raft request' (duration: 111.098433ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:29.51537Z","caller":"traceutil/trace.go:171","msg":"trace[2145769830] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"160.608125ms","start":"2026-07-30T19:34:29.354707Z","end":"2026-07-30T19:34:29.515316Z","steps":["trace[2145769830] 'process raft request' (duration: 160.41002ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:29.612114Z","caller":"traceutil/trace.go:171","msg":"trace[351227976] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"257.365957ms","start":"2026-07-30T19:34:29.354707Z","end":"2026-07-30T19:34:29.612073Z","steps":["trace[351227976] 'process raft request' (duration: 204.346849ms)","trace[351227976] 'compare' (duration: 52.862434ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:29.912175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.295156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:34:29.912294Z","caller":"traceutil/trace.go:171","msg":"trace[1225830743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2247; }","duration":"149.487401ms","start":"2026-07-30T19:34:29.762778Z","end":"2026-07-30T19:34:29.912265Z","steps":["trace[1225830743] 'range keys from in-memory index tree' (duration: 149.129201ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:30.882686Z","caller":"traceutil/trace.go:171","msg":"trace[1861269513] linearizableReadLoop","detail":"{readStateIndex:2342; appliedIndex:2341; }","duration":"149.824311ms","start":"2026-07-30T19:34:30.732828Z","end":"2026-07-30T19:34:30.882652Z","steps":["trace[1861269513] 'read index received' (duration: 149.608295ms)","trace[1861269513] 'applied index is now lower than readState.Index' (duration: 212.336µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:30.882821Z","caller":"traceutil/trace.go:171","msg":"trace[1292745757] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"163.535355ms","start":"2026-07-30T19:34:30.719235Z","end":"2026-07-30T19:34:30.88277Z","steps":["trace[1292745757] 'process raft request' (duration: 163.221366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:30.882915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.600286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:34:30.882962Z","caller":"traceutil/trace.go:171","msg":"trace[1362715356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2250; }","duration":"119.724979ms","start":"2026-07-30T19:34:30.76322Z","end":"2026-07-30T19:34:30.882945Z","steps":["trace[1362715356] 'agreement among raft nodes before linearized reading' (duration: 119.622446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:30.883008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.167769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-30T19:34:30.883046Z","caller":"traceutil/trace.go:171","msg":"trace[2071015846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2250; }","duration":"150.279293ms","start":"2026-07-30T19:34:30.732756Z","end":"2026-07-30T19:34:30.883036Z","steps":["trace[2071015846] 'agreement among raft nodes before linearized reading' (duration: 150.072107ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:31.168998Z","caller":"traceutil/trace.go:171","msg":"trace[1801795372] linearizableReadLoop","detail":"{readStateIndex:2344; appliedIndex:2343; }","duration":"126.025421ms","start":"2026-07-30T19:34:31.042944Z","end":"2026-07-30T19:34:31.168969Z","steps":["trace[1801795372] 'read index received' (duration: 125.806615ms)","trace[1801795372] 'applied index is now lower than readState.Index' (duration: 217.916µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:31.169057Z","caller":"traceutil/trace.go:171","msg":"trace[769122982] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"224.554921ms","start":"2026-07-30T19:34:30.944461Z","end":"2026-07-30T19:34:31.169016Z","steps":["trace[769122982] 'process raft request' (duration: 224.358546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:31.16923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.242487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-07-30T19:34:31.169266Z","caller":"traceutil/trace.go:171","msg":"trace[1104228301] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2252; }","duration":"126.377151ms","start":"2026-07-30T19:34:31.042878Z","end":"2026-07-30T19:34:31.169255Z","steps":["trace[1104228301] 'agreement among raft nodes before linearized reading' (duration: 126.197346ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:31.278366Z","caller":"traceutil/trace.go:171","msg":"trace[2012602350] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"105.783209ms","start":"2026-07-30T19:34:31.17254Z","end":"2026-07-30T19:34:31.278323Z","steps":["trace[2012602350] 'process raft request' (duration: 89.472243ms)","trace[2012602350] 'compare' (duration: 15.961426ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:31.598999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.190089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:34:31.599085Z","caller":"traceutil/trace.go:171","msg":"trace[1102041494] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2254; }","duration":"187.354284ms","start":"2026-07-30T19:34:31.41171Z","end":"2026-07-30T19:34:31.599064Z","steps":["trace[1102041494] 'count revisions from in-memory index tree' (duration: 187.051646ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:31.889631Z","caller":"traceutil/trace.go:171","msg":"trace[1989664839] linearizableReadLoop","detail":"{readStateIndex:2348; appliedIndex:2347; }","duration":"126.673889ms","start":"2026-07-30T19:34:31.762927Z","end":"2026-07-30T19:34:31.889601Z","steps":["trace[1989664839] 'read index received' (duration: 45.238965ms)","trace[1989664839] 'applied index is now lower than readState.Index' (duration: 81.433514ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:31.889761Z","caller":"traceutil/trace.go:171","msg":"trace[1870720437] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"191.278123ms","start":"2026-07-30T19:34:31.698472Z","end":"2026-07-30T19:34:31.88975Z","steps":["trace[1870720437] 'process raft request' (duration: 109.793268ms)","trace[1870720437] 'compare' (duration: 81.232548ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:31.890038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.7887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-30T19:34:31.890188Z","caller":"traceutil/trace.go:171","msg":"trace[1268601896] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2256; }","duration":"123.995685ms","start":"2026-07-30T19:34:31.766161Z","end":"2026-07-30T19:34:31.890157Z","steps":["trace[1268601896] 'agreement among raft nodes before linearized reading' (duration: 123.692277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:31.890112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.173462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:34:31.890374Z","caller":"traceutil/trace.go:171","msg":"trace[1504297612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2256; }","duration":"127.492481ms","start":"2026-07-30T19:34:31.762867Z","end":"2026-07-30T19:34:31.890359Z","steps":["trace[1504297612] 'agreement among raft nodes before linearized reading' (duration: 127.189623ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:32.369264Z","caller":"traceutil/trace.go:171","msg":"trace[596104710] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"249.873362ms","start":"2026-07-30T19:34:32.119359Z","end":"2026-07-30T19:34:32.369232Z","steps":["trace[596104710] 'process raft request' (duration: 249.707318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:32.603542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.3472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-30T19:34:32.603653Z","caller":"traceutil/trace.go:171","msg":"trace[327919026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2258; }","duration":"137.517735ms","start":"2026-07-30T19:34:32.466107Z","end":"2026-07-30T19:34:32.603625Z","steps":["trace[327919026] 'range keys from in-memory index tree' (duration: 136.548198ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:32.708211Z","caller":"traceutil/trace.go:171","msg":"trace[1917206193] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"100.462822ms","start":"2026-07-30T19:34:32.607722Z","end":"2026-07-30T19:34:32.708185Z","steps":["trace[1917206193] 'process raft request' (duration: 100.295158ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:33.081337Z","caller":"traceutil/trace.go:171","msg":"trace[1870230664] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"130.492803ms","start":"2026-07-30T19:34:32.950819Z","end":"2026-07-30T19:34:33.081312Z","steps":["trace[1870230664] 'process raft request' (duration: 130.359309ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:33.82909Z","caller":"traceutil/trace.go:171","msg":"trace[397018223] linearizableReadLoop","detail":"{readStateIndex:2356; appliedIndex:2355; }","duration":"133.731561ms","start":"2026-07-30T19:34:33.695337Z","end":"2026-07-30T19:34:33.829068Z","steps":["trace[397018223] 'read index received' (duration: 133.623568ms)","trace[397018223] 'applied index is now lower than readState.Index' (duration: 106.943µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:33.829289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.930486ms","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-07-30T19:34:33.829322Z","caller":"traceutil/trace.go:171","msg":"trace[468060014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2263; }","duration":"134.027559ms","start":"2026-07-30T19:34:33.695285Z","end":"2026-07-30T19:34:33.829312Z","steps":["trace[468060014] 'agreement among raft nodes before linearized reading' (duration: 133.878065ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:33.829406Z","caller":"traceutil/trace.go:171","msg":"trace[1476518594] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"152.331208ms","start":"2026-07-30T19:34:33.677035Z","end":"2026-07-30T19:34:33.829366Z","steps":["trace[1476518594] 'process raft request' (duration: 151.906857ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:34.231179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.561765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:34:34.231431Z","caller":"traceutil/trace.go:171","msg":"trace[1685352011] linearizableReadLoop","detail":"{readStateIndex:2358; appliedIndex:2356; }","duration":"369.477778ms","start":"2026-07-30T19:34:33.86193Z","end":"2026-07-30T19:34:34.231408Z","steps":["trace[1685352011] 'read index received' (duration: 49.530753ms)","trace[1685352011] 'applied index is now lower than readState.Index' (duration: 319.945615ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:34.231701Z","caller":"traceutil/trace.go:171","msg":"trace[1145552519] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"408.249636ms","start":"2026-07-30T19:34:33.823416Z","end":"2026-07-30T19:34:34.231666Z","steps":["trace[1145552519] 'process raft request' (duration: 88.020603ms)","trace[1145552519] 'compare' (duration: 319.394511ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:34.231793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.839448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6772"} {"level":"info","ts":"2026-07-30T19:34:34.231775Z","caller":"traceutil/trace.go:171","msg":"trace[182721771] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"397.786131ms","start":"2026-07-30T19:34:33.833949Z","end":"2026-07-30T19:34:34.231735Z","steps":["trace[182721771] 'process raft request' (duration: 397.35891ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:34.231846Z","caller":"traceutil/trace.go:171","msg":"trace[778526986] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2265; }","duration":"369.949991ms","start":"2026-07-30T19:34:33.861881Z","end":"2026-07-30T19:34:34.231831Z","steps":["trace[778526986] 'agreement among raft nodes before linearized reading' (duration: 369.655303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:34.231864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:33.823387Z","time spent":"408.395361ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:34:34.231879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.648112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-30T19:34:34.231932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:33.861864Z","time spent":"370.010322ms","remote":"127.0.0.1:51760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":6795,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-30T19:34:34.231939Z","caller":"traceutil/trace.go:171","msg":"trace[1721374963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2265; }","duration":"336.768314ms","start":"2026-07-30T19:34:33.895153Z","end":"2026-07-30T19:34:34.231921Z","steps":["trace[1721374963] 'agreement among raft nodes before linearized reading' (duration: 336.510757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:34.23199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:33.895127Z","time spent":"336.853517ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T19:34:34.231995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:33.833932Z","time spent":"397.943045ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:34:34.60503Z","caller":"traceutil/trace.go:171","msg":"trace[411013615] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"230.528313ms","start":"2026-07-30T19:34:34.374468Z","end":"2026-07-30T19:34:34.604996Z","steps":["trace[411013615] 'process raft request' (duration: 230.468432ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:34.605299Z","caller":"traceutil/trace.go:171","msg":"trace[1304107668] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"367.772462ms","start":"2026-07-30T19:34:34.237483Z","end":"2026-07-30T19:34:34.605256Z","steps":["trace[1304107668] 'process raft request' (duration: 282.938375ms)","trace[1304107668] 'compare' (duration: 84.2427ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:34.605481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:34.237459Z","time spent":"367.926726ms","remote":"127.0.0.1:51854","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-07-30T19:34:36.533375Z","caller":"traceutil/trace.go:171","msg":"trace[1094894033] transaction","detail":"{read_only:false; response_revision:2274; number_of_response:1; }","duration":"245.504222ms","start":"2026-07-30T19:34:36.287838Z","end":"2026-07-30T19:34:36.533342Z","steps":["trace[1094894033] 'process raft request' (duration: 245.326367ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:36.902901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.651101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:34:36.903088Z","caller":"traceutil/trace.go:171","msg":"trace[103004943] transaction","detail":"{read_only:false; response_revision:2277; number_of_response:1; }","duration":"134.522342ms","start":"2026-07-30T19:34:36.768522Z","end":"2026-07-30T19:34:36.903044Z","steps":["trace[103004943] 'process raft request' (duration: 23.610464ms)","trace[103004943] 'compare' (duration: 110.475357ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:37.478295Z","caller":"traceutil/trace.go:171","msg":"trace[813522397] transaction","detail":"{read_only:false; response_revision:2280; number_of_response:1; }","duration":"218.522036ms","start":"2026-07-30T19:34:37.259742Z","end":"2026-07-30T19:34:37.478264Z","steps":["trace[813522397] 'process raft request' (duration: 218.31697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:34:39.816116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.120963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:34:39.816247Z","caller":"traceutil/trace.go:171","msg":"trace[839486147] linearizableReadLoop","detail":"{readStateIndex:2385; appliedIndex:2384; }","duration":"298.684355ms","start":"2026-07-30T19:34:39.517542Z","end":"2026-07-30T19:34:39.816227Z","steps":["trace[839486147] 'read index received' (duration: 64.298375ms)","trace[839486147] 'applied index is now lower than readState.Index' (duration: 234.38462ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:34:39.81632Z","caller":"traceutil/trace.go:171","msg":"trace[1464963003] transaction","detail":"{read_only:false; response_revision:2291; number_of_response:1; }","duration":"300.384811ms","start":"2026-07-30T19:34:39.515883Z","end":"2026-07-30T19:34:39.816268Z","steps":["trace[1464963003] 'process raft request' (duration: 65.995581ms)","trace[1464963003] 'compare' (duration: 233.996819ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:34:39.81659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:34:39.515841Z","time spent":"300.617648ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:34:39.816408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.862229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:34:39.816791Z","caller":"traceutil/trace.go:171","msg":"trace[965705417] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2291; }","duration":"299.271981ms","start":"2026-07-30T19:34:39.51749Z","end":"2026-07-30T19:34:39.816762Z","steps":["trace[965705417] 'agreement among raft nodes before linearized reading' (duration: 298.84515ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:34:40.492871Z","caller":"traceutil/trace.go:171","msg":"trace[81078130] transaction","detail":"{read_only:false; response_revision:2292; number_of_response:1; }","duration":"121.177409ms","start":"2026-07-30T19:34:40.371667Z","end":"2026-07-30T19:34:40.492845Z","steps":["trace[81078130] 'process raft request' (duration: 121.037825ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:12.146511Z","caller":"traceutil/trace.go:171","msg":"trace[541309823] transaction","detail":"{read_only:false; response_revision:2439; number_of_response:1; }","duration":"100.987094ms","start":"2026-07-30T19:35:12.045492Z","end":"2026-07-30T19:35:12.146479Z","steps":["trace[541309823] 'process raft request' (duration: 94.393584ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:15.187314Z","caller":"traceutil/trace.go:171","msg":"trace[400562074] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"132.489778ms","start":"2026-07-30T19:35:15.054798Z","end":"2026-07-30T19:35:15.187288Z","steps":["trace[400562074] 'process raft request' (duration: 132.344104ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:18.853092Z","caller":"traceutil/trace.go:171","msg":"trace[1339638454] transaction","detail":"{read_only:false; response_revision:2467; number_of_response:1; }","duration":"124.233831ms","start":"2026-07-30T19:35:18.728828Z","end":"2026-07-30T19:35:18.853062Z","steps":["trace[1339638454] 'process raft request' (duration: 123.976094ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:32.406623Z","caller":"traceutil/trace.go:171","msg":"trace[663862554] linearizableReadLoop","detail":"{readStateIndex:2656; appliedIndex:2655; }","duration":"219.312503ms","start":"2026-07-30T19:35:32.187279Z","end":"2026-07-30T19:35:32.406591Z","steps":["trace[663862554] 'read index received' (duration: 219.035135ms)","trace[663862554] 'applied index is now lower than readState.Index' (duration: 274.288µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:35:32.406861Z","caller":"traceutil/trace.go:171","msg":"trace[479455519] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"248.979335ms","start":"2026-07-30T19:35:32.157844Z","end":"2026-07-30T19:35:32.406824Z","steps":["trace[479455519] 'process raft request' (duration: 248.572914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:32.406965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.647952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-30T19:35:32.407012Z","caller":"traceutil/trace.go:171","msg":"trace[1672294336] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2551; }","duration":"219.745995ms","start":"2026-07-30T19:35:32.187252Z","end":"2026-07-30T19:35:32.406998Z","steps":["trace[1672294336] 'agreement among raft nodes before linearized reading' (duration: 219.479648ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:39.448237Z","caller":"traceutil/trace.go:171","msg":"trace[2090728393] linearizableReadLoop","detail":"{readStateIndex:2693; appliedIndex:2692; }","duration":"497.989734ms","start":"2026-07-30T19:35:38.950214Z","end":"2026-07-30T19:35:39.448204Z","steps":["trace[2090728393] 'read index received' (duration: 497.731177ms)","trace[2090728393] 'applied index is now lower than readState.Index' (duration: 257.267µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:35:39.448425Z","caller":"traceutil/trace.go:171","msg":"trace[1957205156] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"501.203381ms","start":"2026-07-30T19:35:38.947202Z","end":"2026-07-30T19:35:39.448406Z","steps":["trace[1957205156] 'process raft request' (duration: 500.79646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:39.448577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:38.94717Z","time spent":"501.304594ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:35:39.448743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.605851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-30T19:35:39.448882Z","caller":"traceutil/trace.go:171","msg":"trace[969235483] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2586; }","duration":"414.832987ms","start":"2026-07-30T19:35:39.034025Z","end":"2026-07-30T19:35:39.448858Z","steps":["trace[969235483] 'agreement among raft nodes before linearized reading' (duration: 414.542679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:39.448931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:39.033999Z","time spent":"414.921099ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-30T19:35:39.449177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.488197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-30T19:35:39.449195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.646797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-30T19:35:39.449252Z","caller":"traceutil/trace.go:171","msg":"trace[1876105627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2586; }","duration":"103.763361ms","start":"2026-07-30T19:35:39.345473Z","end":"2026-07-30T19:35:39.449237Z","steps":["trace[1876105627] 'agreement among raft nodes before linearized reading' (duration: 103.564196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:39.449438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.225767ms","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-07-30T19:35:39.449214Z","caller":"traceutil/trace.go:171","msg":"trace[428588986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2586; }","duration":"132.574789ms","start":"2026-07-30T19:35:39.31663Z","end":"2026-07-30T19:35:39.449205Z","steps":["trace[428588986] 'agreement among raft nodes before linearized reading' (duration: 132.482737ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:39.44948Z","caller":"traceutil/trace.go:171","msg":"trace[271885328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2586; }","duration":"499.31386ms","start":"2026-07-30T19:35:38.950155Z","end":"2026-07-30T19:35:39.449469Z","steps":["trace[271885328] 'agreement among raft nodes before linearized reading' (duration: 499.206207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:39.449517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:38.950134Z","time spent":"499.372581ms","remote":"127.0.0.1:51854","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-07-30T19:35:39.573928Z","caller":"traceutil/trace.go:171","msg":"trace[487654912] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"117.570397ms","start":"2026-07-30T19:35:39.45632Z","end":"2026-07-30T19:35:39.57389Z","steps":["trace[487654912] 'process raft request' (duration: 117.31037ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:39.573827Z","caller":"traceutil/trace.go:171","msg":"trace[659908643] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"118.376519ms","start":"2026-07-30T19:35:39.455404Z","end":"2026-07-30T19:35:39.573781Z","steps":["trace[659908643] 'process raft request' (duration: 118.176944ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:39.574592Z","caller":"traceutil/trace.go:171","msg":"trace[53882564] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"119.319356ms","start":"2026-07-30T19:35:39.455196Z","end":"2026-07-30T19:35:39.574515Z","steps":["trace[53882564] 'process raft request' (duration: 118.225876ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:40.021468Z","caller":"traceutil/trace.go:171","msg":"trace[1152102790] linearizableReadLoop","detail":"{readStateIndex:2700; appliedIndex:2699; }","duration":"109.416275ms","start":"2026-07-30T19:35:39.912024Z","end":"2026-07-30T19:35:40.02144Z","steps":["trace[1152102790] 'read index received' (duration: 76.815503ms)","trace[1152102790] 'applied index is now lower than readState.Index' (duration: 32.599702ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:35:40.021729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.679572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2581"} {"level":"info","ts":"2026-07-30T19:35:40.021769Z","caller":"traceutil/trace.go:171","msg":"trace[105759112] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2593; }","duration":"109.742774ms","start":"2026-07-30T19:35:39.912017Z","end":"2026-07-30T19:35:40.021759Z","steps":["trace[105759112] 'agreement among raft nodes before linearized reading' (duration: 109.531988ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:40.022074Z","caller":"traceutil/trace.go:171","msg":"trace[1001527118] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"142.929153ms","start":"2026-07-30T19:35:39.879124Z","end":"2026-07-30T19:35:40.022054Z","steps":["trace[1001527118] 'process raft request' (duration: 109.741174ms)","trace[1001527118] 'compare' (duration: 32.271124ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:35:40.17374Z","caller":"traceutil/trace.go:171","msg":"trace[405497719] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"145.494233ms","start":"2026-07-30T19:35:40.028194Z","end":"2026-07-30T19:35:40.173689Z","steps":["trace[405497719] 'process raft request' (duration: 96.456931ms)","trace[405497719] 'compare' (duration: 48.891728ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:36:17.974808Z","caller":"traceutil/trace.go:171","msg":"trace[117636695] linearizableReadLoop","detail":"{readStateIndex:2887; appliedIndex:2886; }","duration":"157.400927ms","start":"2026-07-30T19:36:17.817382Z","end":"2026-07-30T19:36:17.974783Z","steps":["trace[117636695] 'read index received' (duration: 157.189112ms)","trace[117636695] 'applied index is now lower than readState.Index' (duration: 210.905µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:36:17.974916Z","caller":"traceutil/trace.go:171","msg":"trace[156057394] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"168.273396ms","start":"2026-07-30T19:36:17.806613Z","end":"2026-07-30T19:36:17.974886Z","steps":["trace[156057394] 'process raft request' (duration: 168.03155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:36:17.975164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.745457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-9zwp2\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-30T19:36:17.975276Z","caller":"traceutil/trace.go:171","msg":"trace[1699394695] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-9zwp2; range_end:; response_count:1; response_revision:2773; }","duration":"157.919631ms","start":"2026-07-30T19:36:17.817327Z","end":"2026-07-30T19:36:17.975247Z","steps":["trace[1699394695] 'agreement among raft nodes before linearized reading' (duration: 157.602512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:36:18.329137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.401851ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-07-30T19:36:18.329353Z","caller":"traceutil/trace.go:171","msg":"trace[1709021303] linearizableReadLoop","detail":"{readStateIndex:2889; appliedIndex:2888; }","duration":"276.82318ms","start":"2026-07-30T19:36:18.05251Z","end":"2026-07-30T19:36:18.329333Z","steps":["trace[1709021303] 'read index received' (duration: 81.242513ms)","trace[1709021303] 'applied index is now lower than readState.Index' (duration: 195.578707ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:36:18.329564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.046556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-9zwp2\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-30T19:36:18.329934Z","caller":"traceutil/trace.go:171","msg":"trace[821422049] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-9zwp2; range_end:; response_count:1; response_revision:2774; }","duration":"277.275152ms","start":"2026-07-30T19:36:18.052474Z","end":"2026-07-30T19:36:18.329749Z","steps":["trace[821422049] 'agreement among raft nodes before linearized reading' (duration: 276.954813ms)"],"step_count":1}