{"level":"warn","ts":"2026-06-02T21:31:41.362565Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T21:31:41.362646Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-02T21:31:41.362699Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T21:31:41.362713Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-02T21:31:41.36273Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T21:31:41.363311Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-06-02T21:31:41.363387Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-02T21:31:41.372755Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.131783ms"} {"level":"info","ts":"2026-06-02T21:31:41.379793Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-06-02T21:31:41.379905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T21:31:41.379934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-06-02T21:31:41.379951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T21:31:41.379961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-06-02T21:31:41.380007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-06-02T21:31:41.388237Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T21:31:41.389801Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T21:31:41.393334Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-02T21:31:41.399925Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T21:31:41.400235Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T21:31:41.400384Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T21:31:41.400446Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T21:31:41.400456Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T21:31:41.403145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-06-02T21:31:41.403382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-02T21:31:41.409732Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T21:31:41.409851Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-02T21:31:41.409953Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-02T21:31:41.410138Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T21:31:41.410184Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T21:31:41.880573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T21:31:41.880646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T21:31:41.880693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-06-02T21:31:41.880719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-06-02T21:31:41.880727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-02T21:31:41.880746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-06-02T21:31:41.880771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-02T21:31:41.881764Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T21:31:41.884469Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T21:31:41.884545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T21:31:41.884782Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T21:31:41.885226Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T21:31:41.885324Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T21:31:41.885961Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T21:31:41.886078Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T21:31:41.886115Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T21:31:41.886188Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-06-02T21:31:41.888655Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T21:31:43.675173Z","caller":"traceutil/trace.go:171","msg":"trace[782994619] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"442.040888ms","start":"2026-06-02T21:31:43.233093Z","end":"2026-06-02T21:31:43.675134Z","steps":["trace[782994619] 'read index received' (duration: 441.790543ms)","trace[782994619] 'applied index is now lower than readState.Index' (duration: 249.035µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:31:43.675236Z","caller":"traceutil/trace.go:171","msg":"trace[721351043] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"442.212701ms","start":"2026-06-02T21:31:43.232979Z","end":"2026-06-02T21:31:43.675191Z","steps":["trace[721351043] 'process raft request' (duration: 441.859284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:43.675883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.693859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T21:31:43.677066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.232958Z","time spent":"442.531816ms","remote":"127.0.0.1:60358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:31:43.676249Z","caller":"traceutil/trace.go:171","msg":"trace[2130756614] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:2; }","duration":"442.937555ms","start":"2026-06-02T21:31:43.233049Z","end":"2026-06-02T21:31:43.675987Z","steps":["trace[2130756614] 'agreement among raft nodes before linearized reading' (duration: 442.231201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:43.677356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.232439Z","time spent":"444.773388ms","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-02T21:31:44.176292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981595778,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T21:31:44.677295Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981595778,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T21:31:45.177735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981595778,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T21:31:45.402705Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.000542929s","expected-duration":"1s"} {"level":"info","ts":"2026-06-02T21:31:45.403408Z","caller":"traceutil/trace.go:171","msg":"trace[1353014348] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.109809175s","start":"2026-06-02T21:31:43.293538Z","end":"2026-06-02T21:31:45.403348Z","steps":["trace[1353014348] 'process raft request' (duration: 2.109413978s)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:45.403611Z","caller":"traceutil/trace.go:171","msg":"trace[1922602482] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.108919878s","start":"2026-06-02T21:31:43.29468Z","end":"2026-06-02T21:31:45.4036Z","steps":["trace[1922602482] 'process raft request' (duration: 2.108535171s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.403745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294636Z","time spent":"2.109028021s","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:31:45.403769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.29352Z","time spent":"2.11011876s","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.403522Z","caller":"traceutil/trace.go:171","msg":"trace[994920227] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.108698224s","start":"2026-06-02T21:31:43.294774Z","end":"2026-06-02T21:31:45.403472Z","steps":["trace[994920227] 'process raft request' (duration: 2.108482071s)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:45.403728Z","caller":"traceutil/trace.go:171","msg":"trace[1315521937] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.108724005s","start":"2026-06-02T21:31:43.294963Z","end":"2026-06-02T21:31:45.403687Z","steps":["trace[1315521937] 'process raft request' (duration: 2.108365218s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.404046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294745Z","time spent":"2.109206264s","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.403523Z","caller":"traceutil/trace.go:171","msg":"trace[915284482] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.108678344s","start":"2026-06-02T21:31:43.294823Z","end":"2026-06-02T21:31:45.403502Z","steps":["trace[915284482] 'process raft request' (duration: 2.10846934s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.404263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294941Z","time spent":"2.109218475s","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:31:45.404362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294793Z","time spent":"2.1095176s","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.404674Z","caller":"traceutil/trace.go:171","msg":"trace[1091853703] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.109672343s","start":"2026-06-02T21:31:43.294976Z","end":"2026-06-02T21:31:45.404648Z","steps":["trace[1091853703] 'process raft request' (duration: 2.108390299s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.404784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294964Z","time spent":"2.109752274s","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.404821Z","caller":"traceutil/trace.go:171","msg":"trace[1420005167] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.086358603s","start":"2026-06-02T21:31:43.31843Z","end":"2026-06-02T21:31:45.404789Z","steps":["trace[1420005167] 'process raft request' (duration: 2.0861664s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.404971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.318416Z","time spent":"2.086479665s","remote":"127.0.0.1:60466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.404815Z","caller":"traceutil/trace.go:171","msg":"trace[219519607] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.084257753s","start":"2026-06-02T21:31:43.320529Z","end":"2026-06-02T21:31:45.404787Z","steps":["trace[219519607] 'process raft request' (duration: 2.084207972s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.405117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.320512Z","time spent":"2.084552709s","remote":"127.0.0.1:60578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:31:45.428402Z","caller":"traceutil/trace.go:171","msg":"trace[1194737454] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"1.752994514s","start":"2026-06-02T21:31:43.67539Z","end":"2026-06-02T21:31:45.428384Z","steps":["trace[1194737454] 'read index received' (duration: 1.727549315s)","trace[1194737454] 'applied index is now lower than readState.Index' (duration: 25.442439ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:31:45.428589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.139194279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.428625Z","caller":"traceutil/trace.go:171","msg":"trace[1685249299] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:0; response_revision:11; }","duration":"2.13926967s","start":"2026-06-02T21:31:43.289348Z","end":"2026-06-02T21:31:45.428618Z","steps":["trace[1685249299] 'agreement among raft nodes before linearized reading' (duration: 2.139157918s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.428598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.053446302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T21:31:45.428679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.140922581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.428704Z","caller":"traceutil/trace.go:171","msg":"trace[258589040] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.140993993s","start":"2026-06-02T21:31:43.287705Z","end":"2026-06-02T21:31:45.428699Z","steps":["trace[258589040] 'agreement among raft nodes before linearized reading' (duration: 2.140959822s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.428649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.28933Z","time spent":"2.139313461s","remote":"127.0.0.1:60330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-06-02T21:31:45.428843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.054167877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.428694Z","caller":"traceutil/trace.go:171","msg":"trace[571744997] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.053575295s","start":"2026-06-02T21:31:43.375098Z","end":"2026-06-02T21:31:45.428673Z","steps":["trace[571744997] 'agreement among raft nodes before linearized reading' (duration: 2.05331021s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.428902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.375089Z","time spent":"2.05380673s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-02T21:31:45.428899Z","caller":"traceutil/trace.go:171","msg":"trace[570636990] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.054253869s","start":"2026-06-02T21:31:43.374632Z","end":"2026-06-02T21:31:45.428886Z","steps":["trace[570636990] 'agreement among raft nodes before linearized reading' (duration: 2.054114055s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.42873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.287675Z","time spent":"2.141045663s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-02T21:31:45.428668Z","caller":"traceutil/trace.go:171","msg":"trace[350073892] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.748264553s","start":"2026-06-02T21:31:43.680372Z","end":"2026-06-02T21:31:45.428637Z","steps":["trace[350073892] 'process raft request' (duration: 1.745752617s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.429104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.374621Z","time spent":"2.05432081s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T21:31:45.429175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.680336Z","time spent":"1.748771344s","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:31:45.428723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.133704995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.429255Z","caller":"traceutil/trace.go:171","msg":"trace[1326808674] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.134275116s","start":"2026-06-02T21:31:43.29497Z","end":"2026-06-02T21:31:45.429245Z","steps":["trace[1326808674] 'agreement among raft nodes before linearized reading' (duration: 2.133649174s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.429293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294908Z","time spent":"2.134378158s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T21:31:45.428758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.188203672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.429377Z","caller":"traceutil/trace.go:171","msg":"trace[388578205] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"2.188861975s","start":"2026-06-02T21:31:43.240506Z","end":"2026-06-02T21:31:45.429368Z","steps":["trace[388578205] 'agreement among raft nodes before linearized reading' (duration: 2.188236462s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.429409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.240496Z","time spent":"2.188906475s","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-02T21:31:45.429526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.085184051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.429589Z","caller":"traceutil/trace.go:171","msg":"trace[1888750022] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.085296423s","start":"2026-06-02T21:31:43.344273Z","end":"2026-06-02T21:31:45.42957Z","steps":["trace[1888750022] 'agreement among raft nodes before linearized reading' (duration: 2.085200812s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.429626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.344262Z","time spent":"2.085358214s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T21:31:45.430113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233345533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.430242Z","caller":"traceutil/trace.go:171","msg":"trace[1552057019] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18; }","duration":"1.233524367s","start":"2026-06-02T21:31:44.196705Z","end":"2026-06-02T21:31:45.43023Z","steps":["trace[1552057019] 'agreement among raft nodes before linearized reading' (duration: 1.233348494s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.43037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:44.196667Z","time spent":"1.233693232s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-06-02T21:31:45.430853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233931235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.430889Z","caller":"traceutil/trace.go:171","msg":"trace[1592748613] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:18; }","duration":"1.234026967s","start":"2026-06-02T21:31:44.196853Z","end":"2026-06-02T21:31:45.43088Z","steps":["trace[1592748613] 'agreement among raft nodes before linearized reading' (duration: 1.233966596s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.430931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:44.196822Z","time spent":"1.234085278s","remote":"127.0.0.1:60676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-06-02T21:31:45.43117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043347215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.431198Z","caller":"traceutil/trace.go:171","msg":"trace[1964297746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"1.043374706s","start":"2026-06-02T21:31:44.387816Z","end":"2026-06-02T21:31:45.43119Z","steps":["trace[1964297746] 'agreement among raft nodes before linearized reading' (duration: 1.043334295s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.431221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:44.387719Z","time spent":"1.043497797s","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:31:45.433743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.13870792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.434005Z","caller":"traceutil/trace.go:171","msg":"trace[1822743655] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"2.139145328s","start":"2026-06-02T21:31:43.294837Z","end":"2026-06-02T21:31:45.433982Z","steps":["trace[1822743655] 'agreement among raft nodes before linearized reading' (duration: 2.133630474s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.434144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:43.294784Z","time spent":"2.139345102s","remote":"127.0.0.1:60370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-02T21:31:45.836539Z","caller":"traceutil/trace.go:171","msg":"trace[1966944363] linearizableReadLoop","detail":"{readStateIndex:97; appliedIndex:96; }","duration":"201.72784ms","start":"2026-06-02T21:31:45.634752Z","end":"2026-06-02T21:31:45.83648Z","steps":["trace[1966944363] 'read index received' (duration: 200.69081ms)","trace[1966944363] 'applied index is now lower than readState.Index' (duration: 1.03556ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:31:45.836656Z","caller":"traceutil/trace.go:171","msg":"trace[1198634323] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"228.73942ms","start":"2026-06-02T21:31:45.607866Z","end":"2026-06-02T21:31:45.836606Z","steps":["trace[1198634323] 'process raft request' (duration: 227.635569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:45.836787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.997975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T21:31:45.836905Z","caller":"traceutil/trace.go:171","msg":"trace[631400] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:93; }","duration":"202.183909ms","start":"2026-06-02T21:31:45.634685Z","end":"2026-06-02T21:31:45.836869Z","steps":["trace[631400] 'agreement among raft nodes before linearized reading' (duration: 201.945615ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:49.399054Z","caller":"traceutil/trace.go:171","msg":"trace[1625429549] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"135.712666ms","start":"2026-06-02T21:31:49.263303Z","end":"2026-06-02T21:31:49.399016Z","steps":["trace[1625429549] 'process raft request' (duration: 135.517633ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:49.621986Z","caller":"traceutil/trace.go:171","msg":"trace[2046035726] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"116.111868ms","start":"2026-06-02T21:31:49.50583Z","end":"2026-06-02T21:31:49.621942Z","steps":["trace[2046035726] 'process raft request' (duration: 115.867463ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:49.62212Z","caller":"traceutil/trace.go:171","msg":"trace[864515955] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"102.307727ms","start":"2026-06-02T21:31:49.519773Z","end":"2026-06-02T21:31:49.622081Z","steps":["trace[864515955] 'process raft request' (duration: 102.175825ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:49.622574Z","caller":"traceutil/trace.go:171","msg":"trace[781925909] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"110.548842ms","start":"2026-06-02T21:31:49.511994Z","end":"2026-06-02T21:31:49.622543Z","steps":["trace[781925909] 'process raft request' (duration: 109.836949ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:56.320104Z","caller":"traceutil/trace.go:171","msg":"trace[1413229276] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"160.937971ms","start":"2026-06-02T21:31:56.159139Z","end":"2026-06-02T21:31:56.320077Z","steps":["trace[1413229276] 'process raft request' (duration: 160.758838ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:56.478552Z","caller":"traceutil/trace.go:171","msg":"trace[769662748] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:367; }","duration":"233.898916ms","start":"2026-06-02T21:31:56.244621Z","end":"2026-06-02T21:31:56.47852Z","steps":["trace[769662748] 'read index received' (duration: 75.39729ms)","trace[769662748] 'applied index is now lower than readState.Index' (duration: 158.500096ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:31:56.478748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.10466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:31:56.478822Z","caller":"traceutil/trace.go:171","msg":"trace[1347097339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:358; }","duration":"234.238463ms","start":"2026-06-02T21:31:56.244566Z","end":"2026-06-02T21:31:56.478804Z","steps":["trace[1347097339] 'agreement among raft nodes before linearized reading' (duration: 234.08801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:56.478831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.350122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-02T21:31:56.47889Z","caller":"traceutil/trace.go:171","msg":"trace[1489829381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:358; }","duration":"203.497885ms","start":"2026-06-02T21:31:56.275371Z","end":"2026-06-02T21:31:56.478869Z","steps":["trace[1489829381] 'agreement among raft nodes before linearized reading' (duration: 203.363522ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:31:56.478762Z","caller":"traceutil/trace.go:171","msg":"trace[694951587] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"317.666793ms","start":"2026-06-02T21:31:56.160975Z","end":"2026-06-02T21:31:56.478642Z","steps":["trace[694951587] 'process raft request' (duration: 290.679265ms)","trace[694951587] 'compare' (duration: 26.635022ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:31:56.479538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:31:56.160947Z","time spent":"318.511279ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:31:56.701209Z","caller":"traceutil/trace.go:171","msg":"trace[357291150] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:372; }","duration":"158.387234ms","start":"2026-06-02T21:31:56.542794Z","end":"2026-06-02T21:31:56.701182Z","steps":["trace[357291150] 'read index received' (duration: 158.120959ms)","trace[357291150] 'applied index is now lower than readState.Index' (duration: 265.055µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:31:56.701301Z","caller":"traceutil/trace.go:171","msg":"trace[2093894419] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"159.704219ms","start":"2026-06-02T21:31:56.541547Z","end":"2026-06-02T21:31:56.701251Z","steps":["trace[2093894419] 'process raft request' (duration: 159.464175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:31:56.70138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.556998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-02T21:31:56.70143Z","caller":"traceutil/trace.go:171","msg":"trace[1537026171] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:361; }","duration":"158.66236ms","start":"2026-06-02T21:31:56.542748Z","end":"2026-06-02T21:31:56.70141Z","steps":["trace[1537026171] 'agreement among raft nodes before linearized reading' (duration: 158.558867ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:02.640105Z","caller":"traceutil/trace.go:171","msg":"trace[697293460] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"134.769128ms","start":"2026-06-02T21:32:02.505322Z","end":"2026-06-02T21:32:02.640092Z","steps":["trace[697293460] 'process raft request' (duration: 134.360421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:02.640515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.303697ms","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-06-02T21:32:02.640572Z","caller":"traceutil/trace.go:171","msg":"trace[2073861326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:376; }","duration":"102.369238ms","start":"2026-06-02T21:32:02.538187Z","end":"2026-06-02T21:32:02.640556Z","steps":["trace[2073861326] 'agreement among raft nodes before linearized reading' (duration: 102.275556ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:02.639893Z","caller":"traceutil/trace.go:171","msg":"trace[1407766928] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"101.677765ms","start":"2026-06-02T21:32:02.538192Z","end":"2026-06-02T21:32:02.639869Z","steps":["trace[1407766928] 'read index received' (duration: 101.272128ms)","trace[1407766928] 'applied index is now lower than readState.Index' (duration: 404.567µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:02.77711Z","caller":"traceutil/trace.go:171","msg":"trace[1082157923] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"130.724952ms","start":"2026-06-02T21:32:02.646339Z","end":"2026-06-02T21:32:02.777064Z","steps":["trace[1082157923] 'process raft request' (duration: 90.84468ms)","trace[1082157923] 'compare' (duration: 39.445314ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:16.003384Z","caller":"traceutil/trace.go:171","msg":"trace[137464557] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"191.411035ms","start":"2026-06-02T21:32:15.81195Z","end":"2026-06-02T21:32:16.003361Z","steps":["trace[137464557] 'process raft request' (duration: 191.262312ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:21.613156Z","caller":"traceutil/trace.go:171","msg":"trace[1800631885] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"259.142402ms","start":"2026-06-02T21:32:21.353987Z","end":"2026-06-02T21:32:21.613129Z","steps":["trace[1800631885] 'process raft request' (duration: 258.514509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.443102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.432863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:32:22.443212Z","caller":"traceutil/trace.go:171","msg":"trace[595367007] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"751.614619ms","start":"2026-06-02T21:32:21.691579Z","end":"2026-06-02T21:32:22.443194Z","steps":["trace[595367007] 'process raft request' (duration: 401.891211ms)","trace[595367007] 'compare' (duration: 349.255309ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:22.443266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:21.691551Z","time spent":"751.69391ms","remote":"127.0.0.1:60398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6516,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:22.900987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.571915ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-02T21:32:22.901393Z","caller":"traceutil/trace.go:171","msg":"trace[1309900436] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"452.194809ms","start":"2026-06-02T21:32:22.449182Z","end":"2026-06-02T21:32:22.901377Z","steps":["trace[1309900436] 'process raft request' (duration: 452.147148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.901645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.449178Z","time spent":"452.424753ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2364,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:22.901713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.461643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-02T21:32:22.901787Z","caller":"traceutil/trace.go:171","msg":"trace[436030600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:457; }","duration":"822.603336ms","start":"2026-06-02T21:32:22.07917Z","end":"2026-06-02T21:32:22.901773Z","steps":["trace[436030600] 'agreement among raft nodes before linearized reading' (duration: 822.340461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.901839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.07915Z","time spent":"822.679537ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:32:22.901424Z","caller":"traceutil/trace.go:171","msg":"trace[1547063572] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:470; }","duration":"822.151168ms","start":"2026-06-02T21:32:22.079215Z","end":"2026-06-02T21:32:22.901366Z","steps":["trace[1547063572] 'read index received' (duration: 14.267898ms)","trace[1547063572] 'applied index is now lower than readState.Index' (duration: 807.874149ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:22.901468Z","caller":"traceutil/trace.go:171","msg":"trace[1247246501] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"452.339361ms","start":"2026-06-02T21:32:22.449116Z","end":"2026-06-02T21:32:22.901456Z","steps":["trace[1247246501] 'process raft request' (duration: 452.038836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.902198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.449099Z","time spent":"453.025615ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1639,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:22.902316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.499368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:32:22.902369Z","caller":"traceutil/trace.go:171","msg":"trace[990369062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"122.59884ms","start":"2026-06-02T21:32:22.779754Z","end":"2026-06-02T21:32:22.902353Z","steps":["trace[990369062] 'agreement among raft nodes before linearized reading' (duration: 122.493409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.902634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.404172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:32:22.902699Z","caller":"traceutil/trace.go:171","msg":"trace[697572441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:457; }","duration":"658.497675ms","start":"2026-06-02T21:32:22.24419Z","end":"2026-06-02T21:32:22.902688Z","steps":["trace[697572441] 'agreement among raft nodes before linearized reading' (duration: 657.995595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:22.902735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.244173Z","time spent":"658.555695ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T21:32:23.45097Z","caller":"traceutil/trace.go:171","msg":"trace[1930415621] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"543.746864ms","start":"2026-06-02T21:32:22.907197Z","end":"2026-06-02T21:32:23.450944Z","steps":["trace[1930415621] 'process raft request' (duration: 536.597019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:23.451147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.907177Z","time spent":"543.857266ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:23.451316Z","caller":"traceutil/trace.go:171","msg":"trace[1702271940] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:475; }","duration":"463.652464ms","start":"2026-06-02T21:32:22.987636Z","end":"2026-06-02T21:32:23.451288Z","steps":["trace[1702271940] 'read index received' (duration: 456.072791ms)","trace[1702271940] 'applied index is now lower than readState.Index' (duration: 7.578363ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:23.451444Z","caller":"traceutil/trace.go:171","msg":"trace[1845039902] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"544.182962ms","start":"2026-06-02T21:32:22.907251Z","end":"2026-06-02T21:32:23.451434Z","steps":["trace[1845039902] 'process raft request' (duration: 543.670673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:23.451541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.907242Z","time spent":"544.228853ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":734,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:23.451579Z","caller":"traceutil/trace.go:171","msg":"trace[1520297346] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"544.359015ms","start":"2026-06-02T21:32:22.907202Z","end":"2026-06-02T21:32:23.451561Z","steps":["trace[1520297346] 'process raft request' (duration: 543.543429ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:23.451632Z","caller":"traceutil/trace.go:171","msg":"trace[295894562] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"543.746793ms","start":"2026-06-02T21:32:22.90785Z","end":"2026-06-02T21:32:23.451597Z","steps":["trace[295894562] 'process raft request' (duration: 543.111171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:23.451681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.907173Z","time spent":"544.443916ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:32:23.451691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.145142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:32:23.451723Z","caller":"traceutil/trace.go:171","msg":"trace[757240522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"207.218654ms","start":"2026-06-02T21:32:23.244495Z","end":"2026-06-02T21:32:23.451713Z","steps":["trace[757240522] 'agreement among raft nodes before linearized reading' (duration: 207.160523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:23.451689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.017252ms","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-06-02T21:32:23.451791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.907839Z","time spent":"543.855405ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:32:23.451821Z","caller":"traceutil/trace.go:171","msg":"trace[1337987270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:462; }","duration":"464.217694ms","start":"2026-06-02T21:32:22.987574Z","end":"2026-06-02T21:32:23.451792Z","steps":["trace[1337987270] 'agreement among raft nodes before linearized reading' (duration: 463.9829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:23.451879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:22.987551Z","time spent":"464.315747ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T21:32:25.743323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981596751,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T21:32:25.948631Z","caller":"traceutil/trace.go:171","msg":"trace[63332865] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"841.482672ms","start":"2026-06-02T21:32:25.107124Z","end":"2026-06-02T21:32:25.948607Z","steps":["trace[63332865] 'process raft request' (duration: 841.259268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:25.948776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.107093Z","time spent":"841.615864ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040201Z","caller":"traceutil/trace.go:171","msg":"trace[162753631] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"931.05236ms","start":"2026-06-02T21:32:25.109119Z","end":"2026-06-02T21:32:26.040171Z","steps":["trace[162753631] 'process raft request' (duration: 930.793415ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:26.040265Z","caller":"traceutil/trace.go:171","msg":"trace[698643045] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"918.375291ms","start":"2026-06-02T21:32:25.121855Z","end":"2026-06-02T21:32:26.04023Z","steps":["trace[698643045] 'process raft request' (duration: 918.206618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.040327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.109092Z","time spent":"931.173691ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.040453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.121835Z","time spent":"918.502293ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040562Z","caller":"traceutil/trace.go:171","msg":"trace[2120216782] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"928.380208ms","start":"2026-06-02T21:32:25.112162Z","end":"2026-06-02T21:32:26.040543Z","steps":["trace[2120216782] 'process raft request' (duration: 927.857579ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:26.040549Z","caller":"traceutil/trace.go:171","msg":"trace[1565308260] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:507; }","duration":"798.056254ms","start":"2026-06-02T21:32:25.242468Z","end":"2026-06-02T21:32:26.040525Z","steps":["trace[1565308260] 'read index received' (duration: 706.00505ms)","trace[1565308260] 'applied index is now lower than readState.Index' (duration: 92.050464ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:26.040604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.112157Z","time spent":"928.430739ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040645Z","caller":"traceutil/trace.go:171","msg":"trace[1201228347] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"864.889293ms","start":"2026-06-02T21:32:25.175745Z","end":"2026-06-02T21:32:26.040634Z","steps":["trace[1201228347] 'process raft request' (duration: 864.624538ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:26.040662Z","caller":"traceutil/trace.go:171","msg":"trace[12387231] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"892.136596ms","start":"2026-06-02T21:32:25.148468Z","end":"2026-06-02T21:32:26.040605Z","steps":["trace[12387231] 'process raft request' (duration: 891.851481ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:26.040705Z","caller":"traceutil/trace.go:171","msg":"trace[1907982192] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"745.593495ms","start":"2026-06-02T21:32:25.295104Z","end":"2026-06-02T21:32:26.040698Z","steps":["trace[1907982192] 'process raft request' (duration: 745.362231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.04105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.295057Z","time spent":"745.952441ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.041071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.133018Z","time spent":"907.958083ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040683Z","caller":"traceutil/trace.go:171","msg":"trace[658528652] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"895.428067ms","start":"2026-06-02T21:32:25.145235Z","end":"2026-06-02T21:32:26.040663Z","steps":["trace[658528652] 'process raft request' (duration: 894.937809ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:26.041113Z","caller":"traceutil/trace.go:171","msg":"trace[113284784] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"895.814864ms","start":"2026-06-02T21:32:25.145279Z","end":"2026-06-02T21:32:26.041094Z","steps":["trace[113284784] 'process raft request' (duration: 894.931768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.041183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.145276Z","time spent":"895.879766ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.041183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.175718Z","time spent":"865.208789ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.041195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.145227Z","time spent":"895.925537ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040744Z","caller":"traceutil/trace.go:171","msg":"trace[1628997151] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"895.368017ms","start":"2026-06-02T21:32:25.145367Z","end":"2026-06-02T21:32:26.040735Z","steps":["trace[1628997151] 'process raft request' (duration: 894.910808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.041475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.145363Z","time spent":"896.079581ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.040806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.350279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:32:26.041549Z","caller":"traceutil/trace.go:171","msg":"trace[179123700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"799.132304ms","start":"2026-06-02T21:32:25.242408Z","end":"2026-06-02T21:32:26.04154Z","steps":["trace[179123700] 'agreement among raft nodes before linearized reading' (duration: 798.342809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.041578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.242381Z","time spent":"799.190955ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T21:32:26.040783Z","caller":"traceutil/trace.go:171","msg":"trace[1947375165] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"895.925577ms","start":"2026-06-02T21:32:25.144739Z","end":"2026-06-02T21:32:26.040665Z","steps":["trace[1947375165] 'process raft request' (duration: 895.397468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.041731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.144705Z","time spent":"896.901807ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:26.040709Z","caller":"traceutil/trace.go:171","msg":"trace[1829895065] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"910.97452ms","start":"2026-06-02T21:32:25.129721Z","end":"2026-06-02T21:32:26.040696Z","steps":["trace[1829895065] 'process raft request' (duration: 910.377289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.041829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.129699Z","time spent":"912.106762ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:26.048513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.636405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-02T21:32:26.048571Z","caller":"traceutil/trace.go:171","msg":"trace[1190235862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"591.764048ms","start":"2026-06-02T21:32:25.456794Z","end":"2026-06-02T21:32:26.048558Z","steps":["trace[1190235862] 'agreement among raft nodes before linearized reading' (duration: 591.490453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.048606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.456768Z","time spent":"591.830489ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T21:32:26.050478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.252516ms","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-06-02T21:32:26.050531Z","caller":"traceutil/trace.go:171","msg":"trace[370814616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"593.330847ms","start":"2026-06-02T21:32:25.457188Z","end":"2026-06-02T21:32:26.050519Z","steps":["trace[370814616] 'agreement among raft nodes before linearized reading' (duration: 593.214525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.051104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.457176Z","time spent":"593.911078ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T21:32:26.051453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.892144ms","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-06-02T21:32:26.051498Z","caller":"traceutil/trace.go:171","msg":"trace[1964108588] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"588.961826ms","start":"2026-06-02T21:32:25.462526Z","end":"2026-06-02T21:32:26.051487Z","steps":["trace[1964108588] 'agreement among raft nodes before linearized reading' (duration: 586.461968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:26.051534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:25.462513Z","time spent":"589.013746ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T21:32:26.856508Z","caller":"traceutil/trace.go:171","msg":"trace[1386577997] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"103.798556ms","start":"2026-06-02T21:32:26.752685Z","end":"2026-06-02T21:32:26.856483Z","steps":["trace[1386577997] 'process raft request' (duration: 82.190628ms)","trace[1386577997] 'compare' (duration: 21.410224ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:27.173118Z","caller":"traceutil/trace.go:171","msg":"trace[202464002] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"115.566808ms","start":"2026-06-02T21:32:27.057534Z","end":"2026-06-02T21:32:27.173101Z","steps":["trace[202464002] 'process raft request' (duration: 115.530687ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:27.173664Z","caller":"traceutil/trace.go:171","msg":"trace[560608633] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"132.700889ms","start":"2026-06-02T21:32:27.040957Z","end":"2026-06-02T21:32:27.173658Z","steps":["trace[560608633] 'process raft request' (duration: 71.080668ms)","trace[560608633] 'compare' (duration: 60.913188ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:27.489782Z","caller":"traceutil/trace.go:171","msg":"trace[123559119] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"105.902266ms","start":"2026-06-02T21:32:27.383838Z","end":"2026-06-02T21:32:27.48974Z","steps":["trace[123559119] 'process raft request' (duration: 18.482889ms)","trace[123559119] 'compare' (duration: 86.969248ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:27.784159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.130876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-06-02T21:32:27.78428Z","caller":"traceutil/trace.go:171","msg":"trace[256992003] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:569; }","duration":"194.3305ms","start":"2026-06-02T21:32:27.589922Z","end":"2026-06-02T21:32:27.784253Z","steps":["trace[256992003] 'range keys from in-memory index tree' (duration: 193.924492ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:27.784334Z","caller":"traceutil/trace.go:171","msg":"trace[770952782] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"149.243932ms","start":"2026-06-02T21:32:27.635063Z","end":"2026-06-02T21:32:27.784307Z","steps":["trace[770952782] 'process raft request' (duration: 145.346518ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:27.943728Z","caller":"traceutil/trace.go:171","msg":"trace[581388823] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"102.167915ms","start":"2026-06-02T21:32:27.84153Z","end":"2026-06-02T21:32:27.943698Z","steps":["trace[581388823] 'process raft request' (duration: 85.632134ms)","trace[581388823] 'compare' (duration: 15.93701ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:32.796585Z","caller":"traceutil/trace.go:171","msg":"trace[1361219279] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"161.100614ms","start":"2026-06-02T21:32:32.635447Z","end":"2026-06-02T21:32:32.796548Z","steps":["trace[1361219279] 'process raft request' (duration: 160.87965ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:33.404458Z","caller":"traceutil/trace.go:171","msg":"trace[684450655] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"354.779323ms","start":"2026-06-02T21:32:33.049628Z","end":"2026-06-02T21:32:33.404407Z","steps":["trace[684450655] 'read index received' (duration: 353.892467ms)","trace[684450655] 'applied index is now lower than readState.Index' (duration: 885.776µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:33.404731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.090119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T21:32:33.404782Z","caller":"traceutil/trace.go:171","msg":"trace[592704454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"355.198572ms","start":"2026-06-02T21:32:33.049573Z","end":"2026-06-02T21:32:33.404771Z","steps":["trace[592704454] 'agreement among raft nodes before linearized reading' (duration: 355.001158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:33.404809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:33.049551Z","time spent":"355.251912ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T21:32:33.404912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.352211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:32:33.405196Z","caller":"traceutil/trace.go:171","msg":"trace[633128618] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"639.743541ms","start":"2026-06-02T21:32:32.764786Z","end":"2026-06-02T21:32:33.40453Z","steps":["trace[633128618] 'process raft request' (duration: 639.031777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:33.405368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:32.764757Z","time spent":"640.477565ms","remote":"127.0.0.1:60382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:32:33.40508Z","caller":"traceutil/trace.go:171","msg":"trace[2048199374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"160.650497ms","start":"2026-06-02T21:32:33.244404Z","end":"2026-06-02T21:32:33.405054Z","steps":["trace[2048199374] 'agreement among raft nodes before linearized reading' (duration: 160.244649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:34.029338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.735011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:32:34.029559Z","caller":"traceutil/trace.go:171","msg":"trace[2030002612] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"561.174872ms","start":"2026-06-02T21:32:33.468352Z","end":"2026-06-02T21:32:34.029527Z","steps":["trace[2030002612] 'process raft request' (duration: 110.123115ms)","trace[2030002612] 'compare' (duration: 450.461036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:34.02989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:33.468312Z","time spent":"561.532358ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:32:34.352611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.538226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-02T21:32:34.352698Z","caller":"traceutil/trace.go:171","msg":"trace[852459220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"159.664388ms","start":"2026-06-02T21:32:34.193011Z","end":"2026-06-02T21:32:34.352676Z","steps":["trace[852459220] 'range keys from in-memory index tree' (duration: 159.360383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:34.35263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.13892ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T21:32:34.35301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.779458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T21:32:34.353042Z","caller":"traceutil/trace.go:171","msg":"trace[1297728021] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"161.836729ms","start":"2026-06-02T21:32:34.191198Z","end":"2026-06-02T21:32:34.353035Z","steps":["trace[1297728021] 'range keys from in-memory index tree' (duration: 161.695987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:34.353942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.391654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-02T21:32:34.354018Z","caller":"traceutil/trace.go:171","msg":"trace[1682038008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"210.532646ms","start":"2026-06-02T21:32:34.143466Z","end":"2026-06-02T21:32:34.353998Z","steps":["trace[1682038008] 'range keys from in-memory index tree' (duration: 209.282373ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:34.352852Z","caller":"traceutil/trace.go:171","msg":"trace[1848356221] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:604; }","duration":"166.393845ms","start":"2026-06-02T21:32:34.186422Z","end":"2026-06-02T21:32:34.352816Z","steps":["trace[1848356221] 'range keys from in-memory index tree' (duration: 166.1085ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:36.082354Z","caller":"traceutil/trace.go:171","msg":"trace[148368364] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"314.697098ms","start":"2026-06-02T21:32:35.767627Z","end":"2026-06-02T21:32:36.082324Z","steps":["trace[148368364] 'process raft request' (duration: 314.476494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:36.082549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:35.767591Z","time spent":"314.859442ms","remote":"127.0.0.1:60348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T21:32:36.086545Z","caller":"traceutil/trace.go:171","msg":"trace[1054743797] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"118.139265ms","start":"2026-06-02T21:32:35.968385Z","end":"2026-06-02T21:32:36.086524Z","steps":["trace[1054743797] 'process raft request' (duration: 118.004833ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:36.220452Z","caller":"traceutil/trace.go:171","msg":"trace[546288770] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"115.519417ms","start":"2026-06-02T21:32:36.104879Z","end":"2026-06-02T21:32:36.220398Z","steps":["trace[546288770] 'process raft request' (duration: 44.807354ms)","trace[546288770] 'compare' (duration: 70.58109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:39.4804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.59511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-06-02T21:32:39.48056Z","caller":"traceutil/trace.go:171","msg":"trace[2057917831] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:684; }","duration":"112.844905ms","start":"2026-06-02T21:32:39.367693Z","end":"2026-06-02T21:32:39.480537Z","steps":["trace[2057917831] 'range keys from in-memory index tree' (duration: 112.326066ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:39.548011Z","caller":"traceutil/trace.go:171","msg":"trace[913651822] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"137.472359ms","start":"2026-06-02T21:32:39.410516Z","end":"2026-06-02T21:32:39.547989Z","steps":["trace[913651822] 'process raft request' (duration: 137.042432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:39.697085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.471318ms","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-06-02T21:32:39.697211Z","caller":"traceutil/trace.go:171","msg":"trace[737226985] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:686; }","duration":"113.661681ms","start":"2026-06-02T21:32:39.583519Z","end":"2026-06-02T21:32:39.697181Z","steps":["trace[737226985] 'range keys from in-memory index tree' (duration: 113.247824ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:39.707206Z","caller":"traceutil/trace.go:171","msg":"trace[986564327] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"107.246561ms","start":"2026-06-02T21:32:39.599927Z","end":"2026-06-02T21:32:39.707173Z","steps":["trace[986564327] 'process raft request' (duration: 106.944735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:39.997254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.631542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:32:39.997415Z","caller":"traceutil/trace.go:171","msg":"trace[1575195651] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"232.734035ms","start":"2026-06-02T21:32:39.764658Z","end":"2026-06-02T21:32:39.997392Z","steps":["trace[1575195651] 'read index received' (duration: 59.910399ms)","trace[1575195651] 'applied index is now lower than readState.Index' (duration: 172.822186ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:39.997495Z","caller":"traceutil/trace.go:171","msg":"trace[1492136303] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"274.754876ms","start":"2026-06-02T21:32:39.722724Z","end":"2026-06-02T21:32:39.997479Z","steps":["trace[1492136303] 'process raft request' (duration: 101.778468ms)","trace[1492136303] 'compare' (duration: 172.481809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:39.997864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.143073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-02T21:32:39.998037Z","caller":"traceutil/trace.go:171","msg":"trace[57797271] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:690; }","duration":"233.357927ms","start":"2026-06-02T21:32:39.764639Z","end":"2026-06-02T21:32:39.997997Z","steps":["trace[57797271] 'agreement among raft nodes before linearized reading' (duration: 232.856997ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:40.085003Z","caller":"traceutil/trace.go:171","msg":"trace[232985668] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"291.085624ms","start":"2026-06-02T21:32:39.793889Z","end":"2026-06-02T21:32:40.084974Z","steps":["trace[232985668] 'process raft request' (duration: 290.854369ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:40.197238Z","caller":"traceutil/trace.go:171","msg":"trace[1177719391] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:713; }","duration":"199.763503ms","start":"2026-06-02T21:32:39.997445Z","end":"2026-06-02T21:32:40.197209Z","steps":["trace[1177719391] 'read index received' (duration: 87.414167ms)","trace[1177719391] 'applied index is now lower than readState.Index' (duration: 112.347896ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:40.197283Z","caller":"traceutil/trace.go:171","msg":"trace[1837063248] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"218.633888ms","start":"2026-06-02T21:32:39.978614Z","end":"2026-06-02T21:32:40.197248Z","steps":["trace[1837063248] 'process raft request' (duration: 185.924393ms)","trace[1837063248] 'compare' (duration: 32.443011ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:32:40.197606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.410779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-06-02T21:32:40.197785Z","caller":"traceutil/trace.go:171","msg":"trace[524354671] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:692; }","duration":"231.554672ms","start":"2026-06-02T21:32:39.966145Z","end":"2026-06-02T21:32:40.197699Z","steps":["trace[524354671] 'agreement among raft nodes before linearized reading' (duration: 231.193855ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:47.906968Z","caller":"traceutil/trace.go:171","msg":"trace[86393515] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"184.427852ms","start":"2026-06-02T21:32:47.722505Z","end":"2026-06-02T21:32:47.906933Z","steps":["trace[86393515] 'read index received' (duration: 184.247939ms)","trace[86393515] 'applied index is now lower than readState.Index' (duration: 178.543µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:32:47.907047Z","caller":"traceutil/trace.go:171","msg":"trace[602191236] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"237.247689ms","start":"2026-06-02T21:32:47.669749Z","end":"2026-06-02T21:32:47.906996Z","steps":["trace[602191236] 'process raft request' (duration: 236.998595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:47.907284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.751359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-m4gvl\" ","response":"range_response_count:1 size:5049"} {"level":"info","ts":"2026-06-02T21:32:47.907335Z","caller":"traceutil/trace.go:171","msg":"trace[1193826472] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-m4gvl; range_end:; response_count:1; response_revision:750; }","duration":"184.867351ms","start":"2026-06-02T21:32:47.722454Z","end":"2026-06-02T21:32:47.907321Z","steps":["trace[1193826472] 'agreement among raft nodes before linearized reading' (duration: 184.678888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:47.907485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.168716ms","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-06-02T21:32:47.907638Z","caller":"traceutil/trace.go:171","msg":"trace[384209022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"112.409221ms","start":"2026-06-02T21:32:47.795195Z","end":"2026-06-02T21:32:47.907604Z","steps":["trace[384209022] 'agreement among raft nodes before linearized reading' (duration: 111.965533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:50.92817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.357057ms","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-06-02T21:32:50.928277Z","caller":"traceutil/trace.go:171","msg":"trace[1148983074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"452.539141ms","start":"2026-06-02T21:32:50.475713Z","end":"2026-06-02T21:32:50.928252Z","steps":["trace[1148983074] 'range keys from in-memory index tree' (duration: 451.993261ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:32:50.92832Z","caller":"traceutil/trace.go:171","msg":"trace[800522274] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"344.041924ms","start":"2026-06-02T21:32:50.58426Z","end":"2026-06-02T21:32:50.928302Z","steps":["trace[800522274] 'process raft request' (duration: 337.665353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:50.928338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:50.475671Z","time spent":"452.655573ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T21:32:50.92848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:50.584228Z","time spent":"344.124514ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:32:50.928756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.938572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T21:32:50.92946Z","caller":"traceutil/trace.go:171","msg":"trace[139848347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"449.921441ms","start":"2026-06-02T21:32:50.479496Z","end":"2026-06-02T21:32:50.929418Z","steps":["trace[139848347] 'range keys from in-memory index tree' (duration: 448.435312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:50.929575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:50.479465Z","time spent":"450.092864ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T21:32:50.929137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.3353ms","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-06-02T21:32:50.929899Z","caller":"traceutil/trace.go:171","msg":"trace[379429191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:771; }","duration":"450.073483ms","start":"2026-06-02T21:32:50.47974Z","end":"2026-06-02T21:32:50.929813Z","steps":["trace[379429191] 'range keys from in-memory index tree' (duration: 449.134556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:32:50.93004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:32:50.479733Z","time spent":"450.260718ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T21:32:50.936785Z","caller":"traceutil/trace.go:171","msg":"trace[1933888880] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"184.74108ms","start":"2026-06-02T21:32:50.752024Z","end":"2026-06-02T21:32:50.936765Z","steps":["trace[1933888880] 'process raft request' (duration: 184.541486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:01.177837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.478711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:33:01.178486Z","caller":"traceutil/trace.go:171","msg":"trace[836554568] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"159.223473ms","start":"2026-06-02T21:33:01.019239Z","end":"2026-06-02T21:33:01.178462Z","steps":["trace[836554568] 'process raft request' (duration: 159.145422ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:33:01.17849Z","caller":"traceutil/trace.go:171","msg":"trace[1120656317] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"159.266624ms","start":"2026-06-02T21:33:01.019192Z","end":"2026-06-02T21:33:01.178458Z","steps":["trace[1120656317] 'process raft request' (duration: 24.08548ms)","trace[1120656317] 'compare' (duration: 134.361099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:33:11.681481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.704173ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-02T21:33:11.68161Z","caller":"traceutil/trace.go:171","msg":"trace[925933939] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"174.519684ms","start":"2026-06-02T21:33:11.50707Z","end":"2026-06-02T21:33:11.68159Z","steps":["trace[925933939] 'read index received' (duration: 14.739671ms)","trace[925933939] 'applied index is now lower than readState.Index' (duration: 159.778173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:33:11.681713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.630277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T21:33:11.681749Z","caller":"traceutil/trace.go:171","msg":"trace[65770698] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:934; }","duration":"174.727369ms","start":"2026-06-02T21:33:11.507008Z","end":"2026-06-02T21:33:11.681735Z","steps":["trace[65770698] 'agreement among raft nodes before linearized reading' (duration: 174.632697ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:33:26.210536Z","caller":"traceutil/trace.go:171","msg":"trace[1555835675] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"174.644187ms","start":"2026-06-02T21:33:26.035824Z","end":"2026-06-02T21:33:26.210468Z","steps":["trace[1555835675] 'process raft request' (duration: 174.226288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:26.457198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.04431ms","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-06-02T21:33:26.457269Z","caller":"traceutil/trace.go:171","msg":"trace[11216051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:987; }","duration":"149.186663ms","start":"2026-06-02T21:33:26.308069Z","end":"2026-06-02T21:33:26.457256Z","steps":["trace[11216051] 'range keys from in-memory index tree' (duration: 148.807766ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:33:27.414009Z","caller":"traceutil/trace.go:171","msg":"trace[205698916] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"133.094335ms","start":"2026-06-02T21:33:27.280891Z","end":"2026-06-02T21:33:27.413985Z","steps":["trace[205698916] 'process raft request' (duration: 132.934162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:27.957982Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981597819,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T21:33:28.155516Z","caller":"traceutil/trace.go:171","msg":"trace[1459331978] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"698.386275ms","start":"2026-06-02T21:33:27.457079Z","end":"2026-06-02T21:33:28.155465Z","steps":["trace[1459331978] 'read index received' (duration: 671.010653ms)","trace[1459331978] 'applied index is now lower than readState.Index' (duration: 27.373882ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:33:28.155659Z","caller":"traceutil/trace.go:171","msg":"trace[1027921816] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"734.465832ms","start":"2026-06-02T21:33:27.421168Z","end":"2026-06-02T21:33:28.155634Z","steps":["trace[1027921816] 'process raft request' (duration: 706.911647ms)","trace[1027921816] 'compare' (duration: 27.092995ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:33:28.15579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.68935ms","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-06-02T21:33:28.155802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:33:27.421135Z","time spent":"734.585834ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:33:28.155825Z","caller":"traceutil/trace.go:171","msg":"trace[846630324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:991; }","duration":"698.780771ms","start":"2026-06-02T21:33:27.457033Z","end":"2026-06-02T21:33:28.155814Z","steps":["trace[846630324] 'agreement among raft nodes before linearized reading' (duration: 698.580497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:28.155856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:33:27.45702Z","time spent":"698.828873ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:33:54.254744Z","caller":"traceutil/trace.go:171","msg":"trace[1409428714] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"662.109539ms","start":"2026-06-02T21:33:53.592599Z","end":"2026-06-02T21:33:54.254709Z","steps":["trace[1409428714] 'process raft request' (duration: 661.947566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:54.254924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:33:53.59257Z","time spent":"662.268333ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:33:54.608351Z","caller":"traceutil/trace.go:171","msg":"trace[2056320051] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"245.092572ms","start":"2026-06-02T21:33:54.363229Z","end":"2026-06-02T21:33:54.608321Z","steps":["trace[2056320051] 'read index received' (duration: 184.002117ms)","trace[2056320051] 'applied index is now lower than readState.Index' (duration: 61.088965ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:33:54.608569Z","caller":"traceutil/trace.go:171","msg":"trace[1457351045] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"305.488062ms","start":"2026-06-02T21:33:54.303019Z","end":"2026-06-02T21:33:54.608507Z","steps":["trace[1457351045] 'process raft request' (duration: 244.119222ms)","trace[1457351045] 'compare' (duration: 61.003643ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:33:54.608768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:33:54.302988Z","time spent":"305.679426ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:33:54.608855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.512059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T21:33:54.609066Z","caller":"traceutil/trace.go:171","msg":"trace[877163498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1077; }","duration":"245.732773ms","start":"2026-06-02T21:33:54.363164Z","end":"2026-06-02T21:33:54.608896Z","steps":["trace[877163498] 'agreement among raft nodes before linearized reading' (duration: 245.411917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:54.656558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.250502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T21:33:54.656675Z","caller":"traceutil/trace.go:171","msg":"trace[303856128] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1078; }","duration":"258.442855ms","start":"2026-06-02T21:33:54.398207Z","end":"2026-06-02T21:33:54.656649Z","steps":["trace[303856128] 'agreement among raft nodes before linearized reading' (duration: 258.178531ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:33:54.656914Z","caller":"traceutil/trace.go:171","msg":"trace[1555963821] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"264.083242ms","start":"2026-06-02T21:33:54.392677Z","end":"2026-06-02T21:33:54.65676Z","steps":["trace[1555963821] 'process raft request' (duration: 263.527502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:54.657053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.402935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:33:54.657135Z","caller":"traceutil/trace.go:171","msg":"trace[1214489038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1078; }","duration":"226.576199ms","start":"2026-06-02T21:33:54.430539Z","end":"2026-06-02T21:33:54.657115Z","steps":["trace[1214489038] 'agreement among raft nodes before linearized reading' (duration: 226.080709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:54.930006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.75944ms","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-06-02T21:33:54.930151Z","caller":"traceutil/trace.go:171","msg":"trace[605420170] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1080; }","duration":"195.985755ms","start":"2026-06-02T21:33:54.734137Z","end":"2026-06-02T21:33:54.930123Z","steps":["trace[605420170] 'range keys from in-memory index tree' (duration: 195.456795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:55.677757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.664246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:33:55.677877Z","caller":"traceutil/trace.go:171","msg":"trace[75753454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1081; }","duration":"433.865309ms","start":"2026-06-02T21:33:55.243985Z","end":"2026-06-02T21:33:55.67785Z","steps":["trace[75753454] 'range keys from in-memory index tree' (duration: 433.548863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:55.677957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:33:55.243952Z","time spent":"433.984671ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:33:57.262383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.752706ms","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-06-02T21:33:57.26249Z","caller":"traceutil/trace.go:171","msg":"trace[341694776] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"253.9212ms","start":"2026-06-02T21:33:57.008542Z","end":"2026-06-02T21:33:57.262463Z","steps":["trace[341694776] 'range keys from in-memory index tree' (duration: 253.472941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:33:57.660633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.932011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:33:57.660738Z","caller":"traceutil/trace.go:171","msg":"trace[702226215] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1088; }","duration":"210.109314ms","start":"2026-06-02T21:33:57.450602Z","end":"2026-06-02T21:33:57.660711Z","steps":["trace[702226215] 'count revisions from in-memory index tree' (duration: 209.83357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:03.047711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.246253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:34:03.047803Z","caller":"traceutil/trace.go:171","msg":"trace[1746066454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1104; }","duration":"246.379756ms","start":"2026-06-02T21:34:02.801399Z","end":"2026-06-02T21:34:03.047778Z","steps":["trace[1746066454] 'range keys from in-memory index tree' (duration: 246.056369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:03.047995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.735698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:34:03.048239Z","caller":"traceutil/trace.go:171","msg":"trace[39593039] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1147; }","duration":"108.634181ms","start":"2026-06-02T21:34:02.939585Z","end":"2026-06-02T21:34:03.048219Z","steps":["trace[39593039] 'read index received' (duration: 36.600258ms)","trace[39593039] 'applied index is now lower than readState.Index' (duration: 72.032883ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:03.048353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.761813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:03.04839Z","caller":"traceutil/trace.go:171","msg":"trace[709235014] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1106; }","duration":"108.844425ms","start":"2026-06-02T21:34:02.939534Z","end":"2026-06-02T21:34:03.048378Z","steps":["trace[709235014] 'agreement among raft nodes before linearized reading' (duration: 108.745693ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:03.04849Z","caller":"traceutil/trace.go:171","msg":"trace[631256924] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"246.959907ms","start":"2026-06-02T21:34:02.801494Z","end":"2026-06-02T21:34:03.048454Z","steps":["trace[631256924] 'process raft request' (duration: 69.614687ms)","trace[631256924] 'compare' (duration: 176.579645ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:03.048924Z","caller":"traceutil/trace.go:171","msg":"trace[385744863] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"244.012621ms","start":"2026-06-02T21:34:02.804507Z","end":"2026-06-02T21:34:03.048519Z","steps":["trace[385744863] 'process raft request' (duration: 243.620743ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:03.19103Z","caller":"traceutil/trace.go:171","msg":"trace[30449236] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"136.757017ms","start":"2026-06-02T21:34:03.054237Z","end":"2026-06-02T21:34:03.190994Z","steps":["trace[30449236] 'process raft request' (duration: 136.564494ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:06.712635Z","caller":"traceutil/trace.go:171","msg":"trace[454573145] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"159.003101ms","start":"2026-06-02T21:34:06.553598Z","end":"2026-06-02T21:34:06.712601Z","steps":["trace[454573145] 'process raft request' (duration: 127.551601ms)","trace[454573145] 'compare' (duration: 30.912669ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:06.990508Z","caller":"traceutil/trace.go:171","msg":"trace[1369318729] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"180.272445ms","start":"2026-06-02T21:34:06.810201Z","end":"2026-06-02T21:34:06.990473Z","steps":["trace[1369318729] 'read index received' (duration: 91.232989ms)","trace[1369318729] 'applied index is now lower than readState.Index' (duration: 89.037846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:06.990787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.570832ms","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-06-02T21:34:06.990843Z","caller":"traceutil/trace.go:171","msg":"trace[665484781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1117; }","duration":"180.686924ms","start":"2026-06-02T21:34:06.810141Z","end":"2026-06-02T21:34:06.990828Z","steps":["trace[665484781] 'agreement among raft nodes before linearized reading' (duration: 180.453949ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:06.991574Z","caller":"traceutil/trace.go:171","msg":"trace[1740232103] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"184.500706ms","start":"2026-06-02T21:34:06.806996Z","end":"2026-06-02T21:34:06.991496Z","steps":["trace[1740232103] 'process raft request' (duration: 94.45484ms)","trace[1740232103] 'compare' (duration: 88.483016ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:07.209989Z","caller":"traceutil/trace.go:171","msg":"trace[558383385] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"141.406785ms","start":"2026-06-02T21:34:07.068548Z","end":"2026-06-02T21:34:07.209955Z","steps":["trace[558383385] 'process raft request' (duration: 78.245211ms)","trace[558383385] 'compare' (duration: 62.889829ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.126088Z","caller":"traceutil/trace.go:171","msg":"trace[216856261] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"126.214665ms","start":"2026-06-02T21:34:12.99984Z","end":"2026-06-02T21:34:13.126055Z","steps":["trace[216856261] 'process raft request' (duration: 126.035772ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.194194Z","caller":"traceutil/trace.go:171","msg":"trace[1221084081] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"194.296133ms","start":"2026-06-02T21:34:12.999873Z","end":"2026-06-02T21:34:13.194169Z","steps":["trace[1221084081] 'process raft request' (duration: 159.321946ms)","trace[1221084081] 'compare' (duration: 34.657561ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.194275Z","caller":"traceutil/trace.go:171","msg":"trace[2035280198] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"193.400816ms","start":"2026-06-02T21:34:13.000859Z","end":"2026-06-02T21:34:13.194259Z","steps":["trace[2035280198] 'process raft request' (duration: 193.213292ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.194234Z","caller":"traceutil/trace.go:171","msg":"trace[34131044] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1185; }","duration":"142.490737ms","start":"2026-06-02T21:34:13.051709Z","end":"2026-06-02T21:34:13.1942Z","steps":["trace[34131044] 'read index received' (duration: 74.259076ms)","trace[34131044] 'applied index is now lower than readState.Index' (duration: 68.230261ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.194317Z","caller":"traceutil/trace.go:171","msg":"trace[331129234] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"166.707128ms","start":"2026-06-02T21:34:13.027604Z","end":"2026-06-02T21:34:13.194311Z","steps":["trace[331129234] 'process raft request' (duration: 166.517444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:13.194665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.922894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T21:34:13.194765Z","caller":"traceutil/trace.go:171","msg":"trace[1982154150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1143; }","duration":"143.116549ms","start":"2026-06-02T21:34:13.051634Z","end":"2026-06-02T21:34:13.194751Z","steps":["trace[1982154150] 'agreement among raft nodes before linearized reading' (duration: 142.67408ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.365246Z","caller":"traceutil/trace.go:171","msg":"trace[193600496] linearizableReadLoop","detail":"{readStateIndex:1192; appliedIndex:1190; }","duration":"131.637639ms","start":"2026-06-02T21:34:13.233582Z","end":"2026-06-02T21:34:13.365219Z","steps":["trace[193600496] 'read index received' (duration: 103.781048ms)","trace[193600496] 'applied index is now lower than readState.Index' (duration: 27.855331ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.365317Z","caller":"traceutil/trace.go:171","msg":"trace[879042242] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"166.016653ms","start":"2026-06-02T21:34:13.199273Z","end":"2026-06-02T21:34:13.36529Z","steps":["trace[879042242] 'process raft request' (duration: 138.099551ms)","trace[879042242] 'compare' (duration: 27.591576ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.365453Z","caller":"traceutil/trace.go:171","msg":"trace[1369097605] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"165.82199ms","start":"2026-06-02T21:34:13.199569Z","end":"2026-06-02T21:34:13.365391Z","steps":["trace[1369097605] 'process raft request' (duration: 165.572395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:13.365553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.950484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-02T21:34:13.365595Z","caller":"traceutil/trace.go:171","msg":"trace[554838612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1146; }","duration":"132.059507ms","start":"2026-06-02T21:34:13.233521Z","end":"2026-06-02T21:34:13.36558Z","steps":["trace[554838612] 'agreement among raft nodes before linearized reading' (duration: 131.877953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:13.365656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.779473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T21:34:13.365751Z","caller":"traceutil/trace.go:171","msg":"trace[1310848462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1146; }","duration":"108.918506ms","start":"2026-06-02T21:34:13.256814Z","end":"2026-06-02T21:34:13.365733Z","steps":["trace[1310848462] 'agreement among raft nodes before linearized reading' (duration: 108.665761ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.513056Z","caller":"traceutil/trace.go:171","msg":"trace[352368055] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"141.888765ms","start":"2026-06-02T21:34:13.37113Z","end":"2026-06-02T21:34:13.513019Z","steps":["trace[352368055] 'process raft request' (duration: 139.766964ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.513175Z","caller":"traceutil/trace.go:171","msg":"trace[1541087903] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"141.947805ms","start":"2026-06-02T21:34:13.371196Z","end":"2026-06-02T21:34:13.513144Z","steps":["trace[1541087903] 'process raft request' (duration: 141.598809ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.513692Z","caller":"traceutil/trace.go:171","msg":"trace[1368786477] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"141.276093ms","start":"2026-06-02T21:34:13.372373Z","end":"2026-06-02T21:34:13.513649Z","steps":["trace[1368786477] 'process raft request' (duration: 140.464438ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.513799Z","caller":"traceutil/trace.go:171","msg":"trace[98189881] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"141.328683ms","start":"2026-06-02T21:34:13.372458Z","end":"2026-06-02T21:34:13.513786Z","steps":["trace[98189881] 'process raft request' (duration: 141.125419ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.650568Z","caller":"traceutil/trace.go:171","msg":"trace[1752984230] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"131.961195ms","start":"2026-06-02T21:34:13.51857Z","end":"2026-06-02T21:34:13.650531Z","steps":["trace[1752984230] 'process raft request' (duration: 131.908434ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.650678Z","caller":"traceutil/trace.go:171","msg":"trace[1163486739] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"132.549256ms","start":"2026-06-02T21:34:13.518057Z","end":"2026-06-02T21:34:13.650606Z","steps":["trace[1163486739] 'process raft request' (duration: 98.291214ms)","trace[1163486739] 'compare' (duration: 33.917176ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:13.987149Z","caller":"traceutil/trace.go:171","msg":"trace[161009111] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"164.21115ms","start":"2026-06-02T21:34:13.822907Z","end":"2026-06-02T21:34:13.987118Z","steps":["trace[161009111] 'process raft request' (duration: 164.164849ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.987513Z","caller":"traceutil/trace.go:171","msg":"trace[1818365780] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"166.149887ms","start":"2026-06-02T21:34:13.821352Z","end":"2026-06-02T21:34:13.987502Z","steps":["trace[1818365780] 'process raft request' (duration: 165.664377ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.987954Z","caller":"traceutil/trace.go:171","msg":"trace[65558711] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"168.910969ms","start":"2026-06-02T21:34:13.819007Z","end":"2026-06-02T21:34:13.987918Z","steps":["trace[65558711] 'process raft request' (duration: 167.796778ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:13.98801Z","caller":"traceutil/trace.go:171","msg":"trace[2064063051] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"166.620445ms","start":"2026-06-02T21:34:13.821344Z","end":"2026-06-02T21:34:13.987965Z","steps":["trace[2064063051] 'process raft request' (duration: 165.632436ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:14.140508Z","caller":"traceutil/trace.go:171","msg":"trace[1388539251] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"144.503224ms","start":"2026-06-02T21:34:13.995972Z","end":"2026-06-02T21:34:14.140475Z","steps":["trace[1388539251] 'process raft request' (duration: 143.692918ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:14.163199Z","caller":"traceutil/trace.go:171","msg":"trace[1284899365] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"166.450553ms","start":"2026-06-02T21:34:13.996709Z","end":"2026-06-02T21:34:14.16316Z","steps":["trace[1284899365] 'process raft request' (duration: 166.28598ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:14.812883Z","caller":"traceutil/trace.go:171","msg":"trace[1183397931] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"167.803778ms","start":"2026-06-02T21:34:14.645054Z","end":"2026-06-02T21:34:14.812858Z","steps":["trace[1183397931] 'process raft request' (duration: 167.641025ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:14.870241Z","caller":"traceutil/trace.go:171","msg":"trace[1105763189] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"160.517619ms","start":"2026-06-02T21:34:14.709655Z","end":"2026-06-02T21:34:14.870172Z","steps":["trace[1105763189] 'process raft request' (duration: 160.325516ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:16.627546Z","caller":"traceutil/trace.go:171","msg":"trace[1387630453] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"136.961781ms","start":"2026-06-02T21:34:16.490551Z","end":"2026-06-02T21:34:16.627513Z","steps":["trace[1387630453] 'read index received' (duration: 136.847579ms)","trace[1387630453] 'applied index is now lower than readState.Index' (duration: 112.542µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:16.627787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.218396ms","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-06-02T21:34:16.627867Z","caller":"traceutil/trace.go:171","msg":"trace[310393142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1198; }","duration":"137.334177ms","start":"2026-06-02T21:34:16.490512Z","end":"2026-06-02T21:34:16.627846Z","steps":["trace[310393142] 'agreement among raft nodes before linearized reading' (duration: 137.110133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:19.059854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520623392s","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-06-02T21:34:19.059929Z","caller":"traceutil/trace.go:171","msg":"trace[816162638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1201; }","duration":"1.520718875s","start":"2026-06-02T21:34:17.539194Z","end":"2026-06-02T21:34:19.059913Z","steps":["trace[816162638] 'range keys from in-memory index tree' (duration: 1.520421479s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:19.059962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:17.539158Z","time spent":"1.520798037s","remote":"127.0.0.1:60592","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-06-02T21:34:19.060385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.646586692s","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-06-02T21:34:19.060416Z","caller":"traceutil/trace.go:171","msg":"trace[1867858863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1201; }","duration":"1.646659124s","start":"2026-06-02T21:34:17.413747Z","end":"2026-06-02T21:34:19.060406Z","steps":["trace[1867858863] 'range keys from in-memory index tree' (duration: 1.646454651s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:19.060455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:17.413722Z","time spent":"1.646727266s","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T21:34:19.060578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.632965043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:34:19.060599Z","caller":"traceutil/trace.go:171","msg":"trace[1983848117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1201; }","duration":"1.633006414s","start":"2026-06-02T21:34:17.427587Z","end":"2026-06-02T21:34:19.060594Z","steps":["trace[1983848117] 'range keys from in-memory index tree' (duration: 1.632896272s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:19.060615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:17.427576Z","time spent":"1.633034565s","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T21:34:19.060945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.780741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-02T21:34:19.061021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.522936346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T21:34:19.061057Z","caller":"traceutil/trace.go:171","msg":"trace[1665008964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1201; }","duration":"419.912343ms","start":"2026-06-02T21:34:18.641119Z","end":"2026-06-02T21:34:19.061031Z","steps":["trace[1665008964] 'range keys from in-memory index tree' (duration: 419.533166ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:19.061119Z","caller":"traceutil/trace.go:171","msg":"trace[779014614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1201; }","duration":"1.523070908s","start":"2026-06-02T21:34:17.538026Z","end":"2026-06-02T21:34:19.061097Z","steps":["trace[779014614] 'range keys from in-memory index tree' (duration: 1.52264958s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:19.061131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:18.641057Z","time spent":"420.053666ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T21:34:19.061166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:17.538013Z","time spent":"1.52314423s","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:34:26.652604Z","caller":"traceutil/trace.go:171","msg":"trace[959178176] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"148.063111ms","start":"2026-06-02T21:34:26.504487Z","end":"2026-06-02T21:34:26.65255Z","steps":["trace[959178176] 'process raft request' (duration: 73.901807ms)","trace[959178176] 'compare' (duration: 74.028111ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:27.50269Z","caller":"traceutil/trace.go:171","msg":"trace[2146561792] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"374.375435ms","start":"2026-06-02T21:34:27.128288Z","end":"2026-06-02T21:34:27.502663Z","steps":["trace[2146561792] 'process raft request' (duration: 374.218292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:27.502876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:27.128272Z","time spent":"374.511688ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:34:27.50313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.124583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-02T21:34:27.503212Z","caller":"traceutil/trace.go:171","msg":"trace[2083422315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1230; }","duration":"308.279956ms","start":"2026-06-02T21:34:27.194919Z","end":"2026-06-02T21:34:27.503199Z","steps":["trace[2083422315] 'agreement among raft nodes before linearized reading' (duration: 308.012481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:27.503262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:27.194889Z","time spent":"308.364707ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T21:34:27.503512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.332283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:27.503566Z","caller":"traceutil/trace.go:171","msg":"trace[363286085] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1230; }","duration":"375.412945ms","start":"2026-06-02T21:34:27.128139Z","end":"2026-06-02T21:34:27.503552Z","steps":["trace[363286085] 'agreement among raft nodes before linearized reading' (duration: 374.659002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:27.503602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:27.128132Z","time spent":"375.460336ms","remote":"127.0.0.1:46712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:27.503689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.506061ms","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-06-02T21:34:27.503731Z","caller":"traceutil/trace.go:171","msg":"trace[1509366912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1230; }","duration":"318.596332ms","start":"2026-06-02T21:34:27.185125Z","end":"2026-06-02T21:34:27.503722Z","steps":["trace[1509366912] 'agreement among raft nodes before linearized reading' (duration: 318.49037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:27.50376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:27.185104Z","time spent":"318.649153ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-02T21:34:27.502779Z","caller":"traceutil/trace.go:171","msg":"trace[607905267] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1280; }","duration":"276.41927ms","start":"2026-06-02T21:34:27.226323Z","end":"2026-06-02T21:34:27.502743Z","steps":["trace[607905267] 'read index received' (duration: 276.397109ms)","trace[607905267] 'applied index is now lower than readState.Index' (duration: 18.761µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:27.523138Z","caller":"traceutil/trace.go:171","msg":"trace[593689040] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"253.615683ms","start":"2026-06-02T21:34:27.269505Z","end":"2026-06-02T21:34:27.523121Z","steps":["trace[593689040] 'process raft request' (duration: 253.577173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:27.523231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.867049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:27.523293Z","caller":"traceutil/trace.go:171","msg":"trace[606651556] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1232; }","duration":"115.93756ms","start":"2026-06-02T21:34:27.40734Z","end":"2026-06-02T21:34:27.523277Z","steps":["trace[606651556] 'agreement among raft nodes before linearized reading' (duration: 115.816098ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:27.523488Z","caller":"traceutil/trace.go:171","msg":"trace[125836165] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"292.021155ms","start":"2026-06-02T21:34:27.231454Z","end":"2026-06-02T21:34:27.523475Z","steps":["trace[125836165] 'process raft request' (duration: 291.535716ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:31.752864Z","caller":"traceutil/trace.go:171","msg":"trace[874824459] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"227.272671ms","start":"2026-06-02T21:34:31.52556Z","end":"2026-06-02T21:34:31.752833Z","steps":["trace[874824459] 'process raft request' (duration: 227.089868ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:31.759798Z","caller":"traceutil/trace.go:171","msg":"trace[883163159] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1292; }","duration":"217.941835ms","start":"2026-06-02T21:34:31.541829Z","end":"2026-06-02T21:34:31.759771Z","steps":["trace[883163159] 'read index received' (duration: 210.795698ms)","trace[883163159] 'applied index is now lower than readState.Index' (duration: 7.144716ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:31.759853Z","caller":"traceutil/trace.go:171","msg":"trace[609361456] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"221.199916ms","start":"2026-06-02T21:34:31.538628Z","end":"2026-06-02T21:34:31.759828Z","steps":["trace[609361456] 'process raft request' (duration: 220.997172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:31.760026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.823308ms","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-06-02T21:34:31.760044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.191679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:34:31.760054Z","caller":"traceutil/trace.go:171","msg":"trace[756344405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1244; }","duration":"210.876079ms","start":"2026-06-02T21:34:31.549171Z","end":"2026-06-02T21:34:31.760047Z","steps":["trace[756344405] 'agreement among raft nodes before linearized reading' (duration: 210.762596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:31.76005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.348618ms","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-06-02T21:34:31.760082Z","caller":"traceutil/trace.go:171","msg":"trace[1064298423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1244; }","duration":"218.25909ms","start":"2026-06-02T21:34:31.541813Z","end":"2026-06-02T21:34:31.760072Z","steps":["trace[1064298423] 'agreement among raft nodes before linearized reading' (duration: 218.095387ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:31.760091Z","caller":"traceutil/trace.go:171","msg":"trace[1203265941] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1244; }","duration":"210.43984ms","start":"2026-06-02T21:34:31.549639Z","end":"2026-06-02T21:34:31.760079Z","steps":["trace[1203265941] 'agreement among raft nodes before linearized reading' (duration: 210.329258ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:32.478528Z","caller":"traceutil/trace.go:171","msg":"trace[2066797579] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"321.826954ms","start":"2026-06-02T21:34:32.156676Z","end":"2026-06-02T21:34:32.478503Z","steps":["trace[2066797579] 'read index received' (duration: 259.735761ms)","trace[2066797579] 'applied index is now lower than readState.Index' (duration: 62.089723ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:32.478808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.11662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T21:34:32.478856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.724194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:32.478896Z","caller":"traceutil/trace.go:171","msg":"trace[321112653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1247; }","duration":"234.814645ms","start":"2026-06-02T21:34:32.24407Z","end":"2026-06-02T21:34:32.478884Z","steps":["trace[321112653] 'agreement among raft nodes before linearized reading' (duration: 234.730703ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:32.478892Z","caller":"traceutil/trace.go:171","msg":"trace[1256845372] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1247; }","duration":"322.217762ms","start":"2026-06-02T21:34:32.156656Z","end":"2026-06-02T21:34:32.478874Z","steps":["trace[1256845372] 'agreement among raft nodes before linearized reading' (duration: 322.067258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:32.478952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:32.156555Z","time spent":"322.379355ms","remote":"127.0.0.1:46732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-02T21:34:34.22135Z","caller":"traceutil/trace.go:171","msg":"trace[1620848702] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"464.39695ms","start":"2026-06-02T21:34:33.756918Z","end":"2026-06-02T21:34:34.221315Z","steps":["trace[1620848702] 'read index received' (duration: 464.241528ms)","trace[1620848702] 'applied index is now lower than readState.Index' (duration: 154.022µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:34.221472Z","caller":"traceutil/trace.go:171","msg":"trace[764314869] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"554.192442ms","start":"2026-06-02T21:34:33.667232Z","end":"2026-06-02T21:34:34.221424Z","steps":["trace[764314869] 'process raft request' (duration: 553.837766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.221616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.686766ms","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-06-02T21:34:34.221665Z","caller":"traceutil/trace.go:171","msg":"trace[844077572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1249; }","duration":"464.814479ms","start":"2026-06-02T21:34:33.756834Z","end":"2026-06-02T21:34:34.221649Z","steps":["trace[844077572] 'agreement among raft nodes before linearized reading' (duration: 464.627865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.221697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.667206Z","time spent":"554.368775ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:34:34.22171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.756802Z","time spent":"464.89986ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T21:34:34.393058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.743903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:34:34.393274Z","caller":"traceutil/trace.go:171","msg":"trace[1339529207] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"167.839569ms","start":"2026-06-02T21:34:34.225413Z","end":"2026-06-02T21:34:34.393253Z","steps":["trace[1339529207] 'process raft request' (duration: 167.781268ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:34.393425Z","caller":"traceutil/trace.go:171","msg":"trace[24602491] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"171.985628ms","start":"2026-06-02T21:34:34.22143Z","end":"2026-06-02T21:34:34.393416Z","steps":["trace[24602491] 'read index received' (duration: 61.792428ms)","trace[24602491] 'applied index is now lower than readState.Index' (duration: 110.19178ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:34.393434Z","caller":"traceutil/trace.go:171","msg":"trace[1327973584] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"627.057192ms","start":"2026-06-02T21:34:33.76632Z","end":"2026-06-02T21:34:34.393377Z","steps":["trace[1327973584] 'process raft request' (duration: 516.885782ms)","trace[1327973584] 'compare' (duration: 109.569109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:34.393621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.729725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T21:34:34.393643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.766264Z","time spent":"627.257315ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:34:34.39369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.537417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T21:34:34.393696Z","caller":"traceutil/trace.go:171","msg":"trace[859688292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"149.846146ms","start":"2026-06-02T21:34:34.24383Z","end":"2026-06-02T21:34:34.393676Z","steps":["trace[859688292] 'agreement among raft nodes before linearized reading' (duration: 149.714264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.393668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.316646ms","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-06-02T21:34:34.393719Z","caller":"traceutil/trace.go:171","msg":"trace[790046878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1251; }","duration":"619.568048ms","start":"2026-06-02T21:34:33.774143Z","end":"2026-06-02T21:34:34.393711Z","steps":["trace[790046878] 'agreement among raft nodes before linearized reading' (duration: 619.346284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.393769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.774078Z","time spent":"619.685001ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:34:34.393769Z","caller":"traceutil/trace.go:171","msg":"trace[13727512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"541.430178ms","start":"2026-06-02T21:34:33.852315Z","end":"2026-06-02T21:34:34.393745Z","steps":["trace[13727512] 'agreement among raft nodes before linearized reading' (duration: 541.141703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.393621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.39677ms","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-06-02T21:34:34.393829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.852253Z","time spent":"541.561422ms","remote":"127.0.0.1:60592","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":"info","ts":"2026-06-02T21:34:34.393859Z","caller":"traceutil/trace.go:171","msg":"trace[947537823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1251; }","duration":"540.648854ms","start":"2026-06-02T21:34:33.853181Z","end":"2026-06-02T21:34:34.39383Z","steps":["trace[947537823] 'agreement among raft nodes before linearized reading' (duration: 540.250917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:34.393975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:33.853174Z","time spent":"540.760687ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T21:34:34.603418Z","caller":"traceutil/trace.go:171","msg":"trace[1160286592] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"201.685754ms","start":"2026-06-02T21:34:34.401705Z","end":"2026-06-02T21:34:34.603391Z","steps":["trace[1160286592] 'process raft request' (duration: 201.488331ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:34.603691Z","caller":"traceutil/trace.go:171","msg":"trace[73601284] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"201.918259ms","start":"2026-06-02T21:34:34.401711Z","end":"2026-06-02T21:34:34.60363Z","steps":["trace[73601284] 'process raft request' (duration: 201.632563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:35.820507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.076805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-02T21:34:35.820632Z","caller":"traceutil/trace.go:171","msg":"trace[116341659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1255; }","duration":"495.276649ms","start":"2026-06-02T21:34:35.325324Z","end":"2026-06-02T21:34:35.8206Z","steps":["trace[116341659] 'range keys from in-memory index tree' (duration: 494.76933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:35.820683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:35.325294Z","time spent":"495.37908ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-02T21:34:36.654869Z","caller":"traceutil/trace.go:171","msg":"trace[985880375] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"410.197348ms","start":"2026-06-02T21:34:36.244642Z","end":"2026-06-02T21:34:36.654839Z","steps":["trace[985880375] 'read index received' (duration: 409.999184ms)","trace[985880375] 'applied index is now lower than readState.Index' (duration: 196.474µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:36.654961Z","caller":"traceutil/trace.go:171","msg":"trace[1341049337] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"829.970748ms","start":"2026-06-02T21:34:35.824945Z","end":"2026-06-02T21:34:36.654916Z","steps":["trace[1341049337] 'process raft request' (duration: 829.672983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:36.65512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.461502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T21:34:36.655171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:35.824926Z","time spent":"830.173063ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:36.655226Z","caller":"traceutil/trace.go:171","msg":"trace[1341543083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"410.633885ms","start":"2026-06-02T21:34:36.244565Z","end":"2026-06-02T21:34:36.655199Z","steps":["trace[1341543083] 'agreement among raft nodes before linearized reading' (duration: 410.440232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:36.655285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.244528Z","time spent":"410.745828ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:34:37.01204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.671545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:34:37.01219Z","caller":"traceutil/trace.go:171","msg":"trace[1764926616] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"357.105426ms","start":"2026-06-02T21:34:36.655054Z","end":"2026-06-02T21:34:37.01216Z","steps":["trace[1764926616] 'read index received' (duration: 167.118316ms)","trace[1764926616] 'applied index is now lower than readState.Index' (duration: 189.98516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:37.012325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.405197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T21:34:37.012371Z","caller":"traceutil/trace.go:171","msg":"trace[208295176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"404.476769ms","start":"2026-06-02T21:34:36.60788Z","end":"2026-06-02T21:34:37.012357Z","steps":["trace[208295176] 'agreement among raft nodes before linearized reading' (duration: 404.314076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.012419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.607867Z","time spent":"404.540561ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T21:34:37.012533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.940328ms","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-06-02T21:34:37.012571Z","caller":"traceutil/trace.go:171","msg":"trace[1289703723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"575.00365ms","start":"2026-06-02T21:34:36.437557Z","end":"2026-06-02T21:34:37.012561Z","steps":["trace[1289703723] 'agreement among raft nodes before linearized reading' (duration: 574.916728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.012622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.437545Z","time spent":"575.06605ms","remote":"127.0.0.1:60592","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-06-02T21:34:37.012618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.70747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:37.012717Z","caller":"traceutil/trace.go:171","msg":"trace[1062444221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"355.837892ms","start":"2026-06-02T21:34:36.656856Z","end":"2026-06-02T21:34:37.012694Z","steps":["trace[1062444221] 'agreement among raft nodes before linearized reading' (duration: 355.664329ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:37.012757Z","caller":"traceutil/trace.go:171","msg":"trace[2098388060] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"612.191968ms","start":"2026-06-02T21:34:36.400549Z","end":"2026-06-02T21:34:37.012741Z","steps":["trace[2098388060] 'process raft request' (duration: 421.695227ms)","trace[2098388060] 'compare' (duration: 189.530072ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:37.012771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.656848Z","time spent":"355.915173ms","remote":"127.0.0.1:60298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:34:37.012837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.40052Z","time spent":"612.2653ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T21:34:37.012454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.463189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-02T21:34:37.012982Z","caller":"traceutil/trace.go:171","msg":"trace[539318994] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:1257; }","duration":"565.021839ms","start":"2026-06-02T21:34:36.447903Z","end":"2026-06-02T21:34:37.012925Z","steps":["trace[539318994] 'agreement among raft nodes before linearized reading' (duration: 564.403197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.013008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.3737ms","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-06-02T21:34:37.013105Z","caller":"traceutil/trace.go:171","msg":"trace[516161247] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1257; }","duration":"614.495502ms","start":"2026-06-02T21:34:36.398585Z","end":"2026-06-02T21:34:37.01308Z","steps":["trace[516161247] 'agreement among raft nodes before linearized reading' (duration: 614.155176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.013137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.44787Z","time spent":"565.202312ms","remote":"127.0.0.1:60330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-06-02T21:34:37.013109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.08387ms","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-06-02T21:34:37.01318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.398518Z","time spent":"614.649805ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T21:34:37.013265Z","caller":"traceutil/trace.go:171","msg":"trace[1298765566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1257; }","duration":"405.275324ms","start":"2026-06-02T21:34:36.607942Z","end":"2026-06-02T21:34:37.013217Z","steps":["trace[1298765566] 'agreement among raft nodes before linearized reading' (duration: 404.761795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.013379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:36.607936Z","time spent":"405.423837ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:34:37.266292Z","caller":"traceutil/trace.go:171","msg":"trace[1112739690] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1309; }","duration":"239.918894ms","start":"2026-06-02T21:34:37.026344Z","end":"2026-06-02T21:34:37.266263Z","steps":["trace[1112739690] 'read index received' (duration: 62.652095ms)","trace[1112739690] 'applied index is now lower than readState.Index' (duration: 177.265599ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:37.266725Z","caller":"traceutil/trace.go:171","msg":"trace[1280993654] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"248.492536ms","start":"2026-06-02T21:34:37.018211Z","end":"2026-06-02T21:34:37.266704Z","steps":["trace[1280993654] 'process raft request' (duration: 247.669411ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:37.267Z","caller":"traceutil/trace.go:171","msg":"trace[937413278] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"248.415345ms","start":"2026-06-02T21:34:37.01857Z","end":"2026-06-02T21:34:37.266985Z","steps":["trace[937413278] 'process raft request' (duration: 247.538979ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:37.267109Z","caller":"traceutil/trace.go:171","msg":"trace[1830124437] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"248.471896ms","start":"2026-06-02T21:34:37.018626Z","end":"2026-06-02T21:34:37.267098Z","steps":["trace[1830124437] 'process raft request' (duration: 247.539429ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:37.267206Z","caller":"traceutil/trace.go:171","msg":"trace[1209475450] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"248.1534ms","start":"2026-06-02T21:34:37.019042Z","end":"2026-06-02T21:34:37.267195Z","steps":["trace[1209475450] 'process raft request' (duration: 247.163412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:37.267346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.976814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:37.267394Z","caller":"traceutil/trace.go:171","msg":"trace[833248382] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1261; }","duration":"241.045495ms","start":"2026-06-02T21:34:37.026336Z","end":"2026-06-02T21:34:37.267381Z","steps":["trace[833248382] 'agreement among raft nodes before linearized reading' (duration: 240.951903ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:37.284362Z","caller":"traceutil/trace.go:171","msg":"trace[755152211] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"194.14744ms","start":"2026-06-02T21:34:37.090162Z","end":"2026-06-02T21:34:37.28431Z","steps":["trace[755152211] 'process raft request' (duration: 193.967227ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:38.141216Z","caller":"traceutil/trace.go:171","msg":"trace[2044781568] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"136.9626ms","start":"2026-06-02T21:34:38.004232Z","end":"2026-06-02T21:34:38.141195Z","steps":["trace[2044781568] 'process raft request' (duration: 136.501561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.397117Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981598480,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T21:34:39.492318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.259450005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.492451Z","caller":"traceutil/trace.go:171","msg":"trace[946653505] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1263; }","duration":"1.259606967s","start":"2026-06-02T21:34:38.232797Z","end":"2026-06-02T21:34:39.492404Z","steps":["trace[946653505] 'range keys from in-memory index tree' (duration: 1.259349683s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.492502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:38.23278Z","time spent":"1.25971127s","remote":"127.0.0.1:60704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-06-02T21:34:39.492747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248508115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.492791Z","caller":"traceutil/trace.go:171","msg":"trace[1371755045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1263; }","duration":"1.248567847s","start":"2026-06-02T21:34:38.244208Z","end":"2026-06-02T21:34:39.492776Z","steps":["trace[1371755045] 'range keys from in-memory index tree' (duration: 1.248453524s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.492829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:38.244197Z","time spent":"1.248624028s","remote":"127.0.0.1:60298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:34:39.493571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.519147ms","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-06-02T21:34:39.493671Z","caller":"traceutil/trace.go:171","msg":"trace[1693980575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1263; }","duration":"833.635799ms","start":"2026-06-02T21:34:38.660012Z","end":"2026-06-02T21:34:39.493648Z","steps":["trace[1693980575] 'range keys from in-memory index tree' (duration: 833.246031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.493723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:38.659961Z","time spent":"833.752281ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-02T21:34:39.566553Z","caller":"traceutil/trace.go:171","msg":"trace[177719031] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"905.875295ms","start":"2026-06-02T21:34:38.660656Z","end":"2026-06-02T21:34:39.566532Z","steps":["trace[177719031] 'process raft request' (duration: 905.678152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.566686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:38.660644Z","time spent":"905.966287ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:34:39.975568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.764976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T21:34:39.975847Z","caller":"traceutil/trace.go:171","msg":"trace[1274200095] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"956.692273ms","start":"2026-06-02T21:34:39.019115Z","end":"2026-06-02T21:34:39.975807Z","steps":["trace[1274200095] 'process raft request' (duration: 584.55648ms)","trace[1274200095] 'compare' (duration: 371.301927ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:39.976068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.019065Z","time spent":"956.883147ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:39.976093Z","caller":"traceutil/trace.go:171","msg":"trace[562017642] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"478.076841ms","start":"2026-06-02T21:34:39.498006Z","end":"2026-06-02T21:34:39.976083Z","steps":["trace[562017642] 'process raft request' (duration: 477.686844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.497982Z","time spent":"478.145642ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:39.976171Z","caller":"traceutil/trace.go:171","msg":"trace[2094511267] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1315; }","duration":"1.079978073s","start":"2026-06-02T21:34:38.896147Z","end":"2026-06-02T21:34:39.976125Z","steps":["trace[2094511267] 'read index received' (duration: 670.198694ms)","trace[2094511267] 'applied index is now lower than readState.Index' (duration: 409.776599ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:39.9759Z","caller":"traceutil/trace.go:171","msg":"trace[580161457] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"403.093823ms","start":"2026-06-02T21:34:39.572784Z","end":"2026-06-02T21:34:39.975878Z","steps":["trace[580161457] 'process raft request' (duration: 403.034892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.572769Z","time spent":"403.51586ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T21:34:39.976358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080204827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.976414Z","caller":"traceutil/trace.go:171","msg":"trace[1203250541] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1267; }","duration":"1.080315019s","start":"2026-06-02T21:34:38.896083Z","end":"2026-06-02T21:34:39.976398Z","steps":["trace[1203250541] 'agreement among raft nodes before linearized reading' (duration: 1.080210757s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:38.896058Z","time spent":"1.080434603s","remote":"127.0.0.1:60434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:39.976577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.677214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.976613Z","caller":"traceutil/trace.go:171","msg":"trace[9617697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1267; }","duration":"882.781866ms","start":"2026-06-02T21:34:39.093819Z","end":"2026-06-02T21:34:39.976601Z","steps":["trace[9617697] 'agreement among raft nodes before linearized reading' (duration: 882.712995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.30091ms","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":"warn","ts":"2026-06-02T21:34:39.976619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.082177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.976646Z","caller":"traceutil/trace.go:171","msg":"trace[1353051388] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1267; }","duration":"475.356671ms","start":"2026-06-02T21:34:39.501281Z","end":"2026-06-02T21:34:39.976638Z","steps":["trace[1353051388] 'agreement among raft nodes before linearized reading' (duration: 475.295989ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:39.976649Z","caller":"traceutil/trace.go:171","msg":"trace[653071852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"473.145948ms","start":"2026-06-02T21:34:39.503495Z","end":"2026-06-02T21:34:39.976641Z","steps":["trace[653071852] 'agreement among raft nodes before linearized reading' (duration: 473.098097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.501273Z","time spent":"475.385851ms","remote":"127.0.0.1:46856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:39.976673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.503474Z","time spent":"473.194339ms","remote":"127.0.0.1:60298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:34:39.976681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.1625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T21:34:39.976743Z","caller":"traceutil/trace.go:171","msg":"trace[1896896652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1267; }","duration":"705.227421ms","start":"2026-06-02T21:34:39.271489Z","end":"2026-06-02T21:34:39.976717Z","steps":["trace[1896896652] 'agreement among raft nodes before linearized reading' (duration: 705.053298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.291723ms","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-06-02T21:34:39.976647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.093789Z","time spent":"882.850167ms","remote":"127.0.0.1:46766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:39.976779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.271484Z","time spent":"705.286883ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T21:34:39.976793Z","caller":"traceutil/trace.go:171","msg":"trace[1536007271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1267; }","duration":"705.343073ms","start":"2026-06-02T21:34:39.271442Z","end":"2026-06-02T21:34:39.976785Z","steps":["trace[1536007271] 'agreement among raft nodes before linearized reading' (duration: 705.224321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.271415Z","time spent":"705.400475ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T21:34:39.976901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.65748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.976925Z","caller":"traceutil/trace.go:171","msg":"trace[1684380650] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1267; }","duration":"790.712061ms","start":"2026-06-02T21:34:39.186206Z","end":"2026-06-02T21:34:39.976918Z","steps":["trace[1684380650] 'agreement among raft nodes before linearized reading' (duration: 790.67463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.97694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.980237ms","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-06-02T21:34:39.976956Z","caller":"traceutil/trace.go:171","msg":"trace[962750970] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1267; }","duration":"705.051898ms","start":"2026-06-02T21:34:39.271899Z","end":"2026-06-02T21:34:39.976951Z","steps":["trace[962750970] 'agreement among raft nodes before linearized reading' (duration: 705.000837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.976951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.18619Z","time spent":"790.753781ms","remote":"127.0.0.1:46798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:39.976972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.27187Z","time spent":"705.096969ms","remote":"127.0.0.1:60592","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-06-02T21:34:39.977062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.819513ms","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-06-02T21:34:39.977074Z","caller":"traceutil/trace.go:171","msg":"trace[923554066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1267; }","duration":"704.866384ms","start":"2026-06-02T21:34:39.272203Z","end":"2026-06-02T21:34:39.97707Z","steps":["trace[923554066] 'agreement among raft nodes before linearized reading' (duration: 704.826624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.977086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.272189Z","time spent":"704.893786ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T21:34:39.977086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.13295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T21:34:39.977114Z","caller":"traceutil/trace.go:171","msg":"trace[29411062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"874.192811ms","start":"2026-06-02T21:34:39.102913Z","end":"2026-06-02T21:34:39.977106Z","steps":["trace[29411062] 'agreement among raft nodes before linearized reading' (duration: 874.15213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.977133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.102894Z","time spent":"874.235792ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T21:34:39.977138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.931181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T21:34:39.977192Z","caller":"traceutil/trace.go:171","msg":"trace[630698857] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1267; }","duration":"848.032033ms","start":"2026-06-02T21:34:39.129146Z","end":"2026-06-02T21:34:39.977178Z","steps":["trace[630698857] 'agreement among raft nodes before linearized reading' (duration: 847.939522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:39.977237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.129113Z","time spent":"848.111084ms","remote":"127.0.0.1:60676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-06-02T21:34:40.309195Z","caller":"traceutil/trace.go:171","msg":"trace[1557887658] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"326.842389ms","start":"2026-06-02T21:34:39.982311Z","end":"2026-06-02T21:34:40.309153Z","steps":["trace[1557887658] 'process raft request' (duration: 246.410646ms)","trace[1557887658] 'compare' (duration: 80.162798ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T21:34:40.309397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.98228Z","time spent":"327.006242ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:40.322875Z","caller":"traceutil/trace.go:171","msg":"trace[1821574346] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"340.319856ms","start":"2026-06-02T21:34:39.982523Z","end":"2026-06-02T21:34:40.322843Z","steps":["trace[1821574346] 'process raft request' (duration: 339.455099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:40.323103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.98251Z","time spent":"340.465599ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:40.323404Z","caller":"traceutil/trace.go:171","msg":"trace[197371280] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"340.648753ms","start":"2026-06-02T21:34:39.982675Z","end":"2026-06-02T21:34:40.323323Z","steps":["trace[197371280] 'process raft request' (duration: 339.46164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:40.323501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.982662Z","time spent":"340.791865ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:40.32356Z","caller":"traceutil/trace.go:171","msg":"trace[1589776992] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"340.878947ms","start":"2026-06-02T21:34:39.982662Z","end":"2026-06-02T21:34:40.323541Z","steps":["trace[1589776992] 'process raft request' (duration: 339.572132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:40.323666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:39.982618Z","time spent":"340.982269ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:40.323747Z","caller":"traceutil/trace.go:171","msg":"trace[1479623648] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"160.02317ms","start":"2026-06-02T21:34:40.163716Z","end":"2026-06-02T21:34:40.323739Z","steps":["trace[1479623648] 'process raft request' (duration: 158.583292ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:42.255485Z","caller":"traceutil/trace.go:171","msg":"trace[819755358] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"268.864364ms","start":"2026-06-02T21:34:41.986601Z","end":"2026-06-02T21:34:42.255466Z","steps":["trace[819755358] 'process raft request' (duration: 268.718901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:50.080273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220251981598639,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T21:34:50.112208Z","caller":"traceutil/trace.go:171","msg":"trace[2068091483] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"988.273595ms","start":"2026-06-02T21:34:49.123904Z","end":"2026-06-02T21:34:50.112178Z","steps":["trace[2068091483] 'process raft request' (duration: 988.0981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:50.11237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:49.123869Z","time spent":"988.417997ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T21:34:50.223819Z","caller":"traceutil/trace.go:171","msg":"trace[106846690] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1403; }","duration":"643.84832ms","start":"2026-06-02T21:34:49.579943Z","end":"2026-06-02T21:34:50.223791Z","steps":["trace[106846690] 'read index received' (duration: 532.180953ms)","trace[106846690] 'applied index is now lower than readState.Index' (duration: 111.666337ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T21:34:50.223879Z","caller":"traceutil/trace.go:171","msg":"trace[1846062474] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"157.506481ms","start":"2026-06-02T21:34:50.066337Z","end":"2026-06-02T21:34:50.223844Z","steps":["trace[1846062474] 'process raft request' (duration: 154.079616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:50.224117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.127566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T21:34:50.224209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.601956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-5m82m\" ","response":"range_response_count:1 size:12641"} {"level":"info","ts":"2026-06-02T21:34:50.224234Z","caller":"traceutil/trace.go:171","msg":"trace[1588974809] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1351; }","duration":"644.32482ms","start":"2026-06-02T21:34:49.579883Z","end":"2026-06-02T21:34:50.224208Z","steps":["trace[1588974809] 'agreement among raft nodes before linearized reading' (duration: 644.057314ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T21:34:50.224287Z","caller":"traceutil/trace.go:171","msg":"trace[2015027230] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-5m82m; range_end:; response_count:1; response_revision:1351; }","duration":"463.701268ms","start":"2026-06-02T21:34:49.760562Z","end":"2026-06-02T21:34:50.224263Z","steps":["trace[2015027230] 'agreement among raft nodes before linearized reading' (duration: 463.458872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T21:34:50.224304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:49.579858Z","time spent":"644.432892ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-06-02T21:34:50.224334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T21:34:49.760517Z","time spent":"463.80554ms","remote":"127.0.0.1:60474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12663,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-5m82m\" "} {"level":"info","ts":"2026-06-02T21:35:50.692534Z","caller":"traceutil/trace.go:171","msg":"trace[607917489] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"169.936768ms","start":"2026-06-02T21:35:50.522555Z","end":"2026-06-02T21:35:50.692492Z","steps":["trace[607917489] 'process raft request' (duration: 134.547504ms)","trace[607917489] 'compare' (duration: 35.17937ms)"],"step_count":2}