{"level":"warn","ts":"2026-07-23T23:52:33.631473Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:52:33.631584Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-23T23:52:33.631654Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:52:33.631671Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-07-23T23:52:33.631691Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-23T23:52:33.632347Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-07-23T23:52:33.632506Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-23T23:52:33.634855Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.003038ms"} {"level":"info","ts":"2026-07-23T23:52:33.645412Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-07-23T23:52:33.645586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T23:52:33.645768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-07-23T23:52:33.64584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T23:52:33.645888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-07-23T23:52:33.646163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-07-23T23:52:33.650715Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T23:52:33.652056Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T23:52:33.653127Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-23T23:52:33.655385Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T23:52:33.659466Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-23T23:52:33.660168Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-23T23:52:33.660573Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T23:52:33.661327Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-23T23:52:33.662742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-07-23T23:52:33.662997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-07-23T23:52:33.663159Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-23T23:52:33.663281Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-07-23T23:52:33.663356Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-07-23T23:52:33.663546Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T23:52:33.663606Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T23:52:34.446613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T23:52:34.446726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T23:52:34.44675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-07-23T23:52:34.446771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-07-23T23:52:34.446782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-07-23T23:52:34.446799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-07-23T23:52:34.446813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-07-23T23:52:34.460011Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:52:34.470481Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:52:34.470547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:52:34.471161Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T23:52:34.471206Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T23:52:34.470441Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T23:52:34.473977Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-23T23:52:34.475241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-07-23T23:52:34.480126Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:52:34.48031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:52:34.48035Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:52:36.23796Z","caller":"traceutil/trace.go:171","msg":"trace[1656211243] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"424.084275ms","start":"2026-07-23T23:52:35.813848Z","end":"2026-07-23T23:52:36.237932Z","steps":["trace[1656211243] 'read index received' (duration: 423.988573ms)","trace[1656211243] 'applied index is now lower than readState.Index' (duration: 94.642µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:36.238033Z","caller":"traceutil/trace.go:171","msg":"trace[2063052159] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"430.703142ms","start":"2026-07-23T23:52:35.807266Z","end":"2026-07-23T23:52:36.237969Z","steps":["trace[2063052159] 'process raft request' (duration: 430.440196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.238202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.31707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:52:36.238318Z","caller":"traceutil/trace.go:171","msg":"trace[1725905939] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"424.464184ms","start":"2026-07-23T23:52:35.813834Z","end":"2026-07-23T23:52:36.238298Z","steps":["trace[1725905939] 'agreement among raft nodes before linearized reading' (duration: 424.221948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.238367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.813828Z","time spent":"424.529776ms","remote":"127.0.0.1:44576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":26,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-23T23:52:36.239151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.807257Z","time spent":"430.934947ms","remote":"127.0.0.1:44450","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-07-23T23:52:36.330037Z","caller":"traceutil/trace.go:171","msg":"trace[2038104315] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"440.644167ms","start":"2026-07-23T23:52:35.889313Z","end":"2026-07-23T23:52:36.329957Z","steps":["trace[2038104315] 'process raft request' (duration: 440.251957ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.330088Z","caller":"traceutil/trace.go:171","msg":"trace[842547004] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"438.996147ms","start":"2026-07-23T23:52:35.891041Z","end":"2026-07-23T23:52:36.330037Z","steps":["trace[842547004] 'process raft request' (duration: 438.784903ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.330096Z","caller":"traceutil/trace.go:171","msg":"trace[1369282724] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"438.527276ms","start":"2026-07-23T23:52:35.89151Z","end":"2026-07-23T23:52:36.330037Z","steps":["trace[1369282724] 'process raft request' (duration: 438.381173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.330175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.889283Z","time spent":"440.816071ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:36.330243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.891012Z","time spent":"439.157512ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:36.330266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.891497Z","time spent":"438.678151ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:52:36.330256Z","caller":"traceutil/trace.go:171","msg":"trace[89244209] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"438.634779ms","start":"2026-07-23T23:52:35.891465Z","end":"2026-07-23T23:52:36.3301Z","steps":["trace[89244209] 'process raft request' (duration: 438.393793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.330372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.340916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:52:36.330383Z","caller":"traceutil/trace.go:171","msg":"trace[826915848] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"439.651403ms","start":"2026-07-23T23:52:35.89072Z","end":"2026-07-23T23:52:36.330372Z","steps":["trace[826915848] 'process raft request' (duration: 439.06941ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.330411Z","caller":"traceutil/trace.go:171","msg":"trace[47404597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"516.388687ms","start":"2026-07-23T23:52:35.814011Z","end":"2026-07-23T23:52:36.3304Z","steps":["trace[47404597] 'agreement among raft nodes before linearized reading' (duration: 516.273264ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.330421Z","caller":"traceutil/trace.go:171","msg":"trace[883165943] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"440.979155ms","start":"2026-07-23T23:52:35.889429Z","end":"2026-07-23T23:52:36.330408Z","steps":["trace[883165943] 'process raft request' (duration: 440.285999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.330431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.890703Z","time spent":"439.707044ms","remote":"127.0.0.1:44894","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-07-23T23:52:36.330444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.814008Z","time spent":"516.429228ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-23T23:52:36.330474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.889393Z","time spent":"441.055797ms","remote":"127.0.0.1:44824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:36.33058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.49308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.330672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.732429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.330603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.891407Z","time spent":"439.014778ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:36.330755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.683614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.330971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.513238ms","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":"warn","ts":"2026-07-23T23:52:36.331057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.832986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.331154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.93365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.331149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.068881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:52:36.331385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.021007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:52:36.331434Z","caller":"traceutil/trace.go:171","msg":"trace[1176724342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"516.755695ms","start":"2026-07-23T23:52:35.814047Z","end":"2026-07-23T23:52:36.330803Z","steps":["trace[1176724342] 'agreement among raft nodes before linearized reading' (duration: 516.551831ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.331477Z","caller":"traceutil/trace.go:171","msg":"trace[1899795187] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"392.325834ms","start":"2026-07-23T23:52:35.939132Z","end":"2026-07-23T23:52:36.331458Z","steps":["trace[1899795187] 'agreement among raft nodes before linearized reading' (duration: 391.819802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.331497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.814045Z","time spent":"517.437482ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-23T23:52:36.331595Z","caller":"traceutil/trace.go:171","msg":"trace[1929755449] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:0; response_revision:10; }","duration":"445.634224ms","start":"2026-07-23T23:52:35.885783Z","end":"2026-07-23T23:52:36.331417Z","steps":["trace[1929755449] 'agreement among raft nodes before linearized reading' (duration: 444.482437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.33171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.885746Z","time spent":"445.948681ms","remote":"127.0.0.1:44406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"info","ts":"2026-07-23T23:52:36.331404Z","caller":"traceutil/trace.go:171","msg":"trace[1030074582] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"430.987518ms","start":"2026-07-23T23:52:35.899734Z","end":"2026-07-23T23:52:36.330722Z","steps":["trace[1030074582] 'process raft request' (duration: 430.19765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.331862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.899722Z","time spent":"432.110584ms","remote":"127.0.0.1:44576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:52:36.331762Z","caller":"traceutil/trace.go:171","msg":"trace[295387594] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"441.65738ms","start":"2026-07-23T23:52:35.889354Z","end":"2026-07-23T23:52:36.331011Z","steps":["trace[295387594] 'agreement among raft nodes before linearized reading' (duration: 441.540667ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:36.331328Z","caller":"traceutil/trace.go:171","msg":"trace[1964814643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"516.545781ms","start":"2026-07-23T23:52:35.814068Z","end":"2026-07-23T23:52:36.330613Z","steps":["trace[1964814643] 'agreement among raft nodes before linearized reading' (duration: 516.464509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.33198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.889324Z","time spent":"442.639883ms","remote":"127.0.0.1:44474","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-07-23T23:52:36.331688Z","caller":"traceutil/trace.go:171","msg":"trace[238361169] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"421.266218ms","start":"2026-07-23T23:52:35.909561Z","end":"2026-07-23T23:52:36.330828Z","steps":["trace[238361169] 'process raft request' (duration: 420.418388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.332298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.90955Z","time spent":"422.67216ms","remote":"127.0.0.1:44660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:36.331574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.939119Z","time spent":"392.439697ms","remote":"127.0.0.1:44506","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-07-23T23:52:36.331373Z","caller":"traceutil/trace.go:171","msg":"trace[601373837] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"366.852232ms","start":"2026-07-23T23:52:35.963856Z","end":"2026-07-23T23:52:36.330709Z","steps":["trace[601373837] 'agreement among raft nodes before linearized reading' (duration: 366.723399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.332562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.963844Z","time spent":"368.706646ms","remote":"127.0.0.1:44506","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-07-23T23:52:36.332009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.814066Z","time spent":"517.935743ms","remote":"127.0.0.1:44368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T23:52:36.332171Z","caller":"traceutil/trace.go:171","msg":"trace[1148960653] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"443.030323ms","start":"2026-07-23T23:52:35.888149Z","end":"2026-07-23T23:52:36.331179Z","steps":["trace[1148960653] 'agreement among raft nodes before linearized reading' (duration: 442.975242ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.332797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.888084Z","time spent":"444.696792ms","remote":"127.0.0.1:44506","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-07-23T23:52:36.332142Z","caller":"traceutil/trace.go:171","msg":"trace[1794277861] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"516.879608ms","start":"2026-07-23T23:52:35.814209Z","end":"2026-07-23T23:52:36.331089Z","steps":["trace[1794277861] 'agreement among raft nodes before linearized reading' (duration: 516.823067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:36.332958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:35.8142Z","time spent":"518.730972ms","remote":"127.0.0.1:44594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":26,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"warn","ts":"2026-07-23T23:52:40.764351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.927012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:52:40.764495Z","caller":"traceutil/trace.go:171","msg":"trace[1003000631] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:271; }","duration":"1.027650506s","start":"2026-07-23T23:52:39.736785Z","end":"2026-07-23T23:52:40.764436Z","steps":["trace[1003000631] 'read index received' (duration: 370.385516ms)","trace[1003000631] 'applied index is now lower than readState.Index' (duration: 657.26391ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:40.764584Z","caller":"traceutil/trace.go:171","msg":"trace[787466320] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"1.052663903s","start":"2026-07-23T23:52:39.711879Z","end":"2026-07-23T23:52:40.764543Z","steps":["trace[787466320] 'process raft request' (duration: 395.360232ms)","trace[787466320] 'compare' (duration: 656.729606ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:40.764656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027872082s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-07-23T23:52:40.764691Z","caller":"traceutil/trace.go:171","msg":"trace[1782219013] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:263; }","duration":"1.027955064s","start":"2026-07-23T23:52:39.736726Z","end":"2026-07-23T23:52:40.764681Z","steps":["trace[1782219013] 'agreement among raft nodes before linearized reading' (duration: 1.027856381s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:40.764769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:39.736703Z","time spent":"1.028052806s","remote":"127.0.0.1:44598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-07-23T23:52:40.765415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:39.711856Z","time spent":"1.052834758s","remote":"127.0.0.1:44598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":170,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:41.265537Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370870891,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:52:41.403625Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.002983537s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-23T23:52:41.910455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.415965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-07-23T23:52:41.910582Z","caller":"traceutil/trace.go:171","msg":"trace[104876790] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"1.510045278s","start":"2026-07-23T23:52:40.400515Z","end":"2026-07-23T23:52:41.910561Z","steps":["trace[104876790] 'process raft request' (duration: 1.003445538s)","trace[104876790] 'compare' (duration: 506.350724ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:41.910692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.400487Z","time spent":"1.51016501s","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:43.078917Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.675043552s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T23:52:43.079293Z","caller":"traceutil/trace.go:171","msg":"trace[1510610338] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:272; }","duration":"2.314737337s","start":"2026-07-23T23:52:40.764529Z","end":"2026-07-23T23:52:43.079266Z","steps":["trace[1510610338] 'read index received' (duration: 639.370328ms)","trace[1510610338] 'applied index is now lower than readState.Index' (duration: 1.675366049s)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:43.079477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.669905188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-23T23:52:43.079515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.66917542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T23:52:43.079584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.680840878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-07-23T23:52:43.079611Z","caller":"traceutil/trace.go:171","msg":"trace[2031600278] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:264; }","duration":"2.68090743s","start":"2026-07-23T23:52:40.398696Z","end":"2026-07-23T23:52:43.079604Z","steps":["trace[2031600278] 'agreement among raft nodes before linearized reading' (duration: 2.680860668s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.079631Z","caller":"traceutil/trace.go:171","msg":"trace[1042902740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:264; }","duration":"2.669348674s","start":"2026-07-23T23:52:40.41024Z","end":"2026-07-23T23:52:43.079589Z","steps":["trace[1042902740] 'agreement among raft nodes before linearized reading' (duration: 2.669097928s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.079646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.398675Z","time spent":"2.68096321s","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5535,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-07-23T23:52:43.079707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.410218Z","time spent":"2.669478388s","remote":"127.0.0.1:44662","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-07-23T23:52:43.079829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.046314682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:52:43.079893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.310347789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:52:43.079924Z","caller":"traceutil/trace.go:171","msg":"trace[1824658871] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:264; }","duration":"2.310403981s","start":"2026-07-23T23:52:40.769508Z","end":"2026-07-23T23:52:43.079912Z","steps":["trace[1824658871] 'agreement among raft nodes before linearized reading' (duration: 2.31036152s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.079926Z","caller":"traceutil/trace.go:171","msg":"trace[1261110714] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"2.678952241s","start":"2026-07-23T23:52:40.400963Z","end":"2026-07-23T23:52:43.079915Z","steps":["trace[1261110714] 'process raft request' (duration: 2.678137241s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.079927Z","caller":"traceutil/trace.go:171","msg":"trace[572602669] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:264; }","duration":"3.046505757s","start":"2026-07-23T23:52:40.033394Z","end":"2026-07-23T23:52:43.0799Z","steps":["trace[572602669] 'agreement among raft nodes before linearized reading' (duration: 3.046319502s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.079949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.769492Z","time spent":"2.310451672s","remote":"127.0.0.1:44598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" "} {"level":"warn","ts":"2026-07-23T23:52:43.079999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.400924Z","time spent":"2.679030663s","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:52:43.079991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.033372Z","time spent":"3.046604879s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-23T23:52:43.080098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16792066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-07-23T23:52:43.080124Z","caller":"traceutil/trace.go:171","msg":"trace[1527429325] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:264; }","duration":"1.167978291s","start":"2026-07-23T23:52:41.912139Z","end":"2026-07-23T23:52:43.080117Z","steps":["trace[1527429325] 'agreement among raft nodes before linearized reading' (duration: 1.16793379s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.080149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:41.912122Z","time spent":"1.168021212s","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4002,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-07-23T23:52:43.080208Z","caller":"traceutil/trace.go:171","msg":"trace[2097558704] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"2.311324133s","start":"2026-07-23T23:52:40.768874Z","end":"2026-07-23T23:52:43.080198Z","steps":["trace[2097558704] 'process raft request' (duration: 2.310309458s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.080259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.768849Z","time spent":"2.311388195s","remote":"127.0.0.1:44748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:52:43.079536Z","caller":"traceutil/trace.go:171","msg":"trace[1119587849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:264; }","duration":"2.670039161s","start":"2026-07-23T23:52:40.409486Z","end":"2026-07-23T23:52:43.079525Z","steps":["trace[1119587849] 'agreement among raft nodes before linearized reading' (duration: 2.669932098s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.080383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.733789346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-23T23:52:43.080408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.409455Z","time spent":"2.670944513s","remote":"127.0.0.1:44662","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-07-23T23:52:43.080431Z","caller":"traceutil/trace.go:171","msg":"trace[555672209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:264; }","duration":"2.733868177s","start":"2026-07-23T23:52:40.346548Z","end":"2026-07-23T23:52:43.080417Z","steps":["trace[555672209] 'agreement among raft nodes before linearized reading' (duration: 2.733719804s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:43.080472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:40.346488Z","time spent":"2.73397251s","remote":"127.0.0.1:44662","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-07-23T23:52:43.33659Z","caller":"traceutil/trace.go:171","msg":"trace[1684624835] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"250.841194ms","start":"2026-07-23T23:52:43.085727Z","end":"2026-07-23T23:52:43.336568Z","steps":["trace[1684624835] 'process raft request' (duration: 250.449745ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340223Z","caller":"traceutil/trace.go:171","msg":"trace[1817934081] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"254.240518ms","start":"2026-07-23T23:52:43.085952Z","end":"2026-07-23T23:52:43.340193Z","steps":["trace[1817934081] 'process raft request' (duration: 254.057004ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340284Z","caller":"traceutil/trace.go:171","msg":"trace[270820722] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"254.255638ms","start":"2026-07-23T23:52:43.085972Z","end":"2026-07-23T23:52:43.340227Z","steps":["trace[270820722] 'process raft request' (duration: 254.124885ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340304Z","caller":"traceutil/trace.go:171","msg":"trace[1662017165] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"254.29845ms","start":"2026-07-23T23:52:43.085946Z","end":"2026-07-23T23:52:43.340244Z","steps":["trace[1662017165] 'process raft request' (duration: 254.118465ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340467Z","caller":"traceutil/trace.go:171","msg":"trace[1382381672] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"252.433063ms","start":"2026-07-23T23:52:43.088021Z","end":"2026-07-23T23:52:43.340455Z","steps":["trace[1382381672] 'process raft request' (duration: 252.110085ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340247Z","caller":"traceutil/trace.go:171","msg":"trace[1770082282] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"243.81285ms","start":"2026-07-23T23:52:43.096411Z","end":"2026-07-23T23:52:43.340223Z","steps":["trace[1770082282] 'process raft request' (duration: 243.765229ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:43.340446Z","caller":"traceutil/trace.go:171","msg":"trace[1784162272] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"254.529175ms","start":"2026-07-23T23:52:43.085881Z","end":"2026-07-23T23:52:43.34041Z","steps":["trace[1784162272] 'process raft request' (duration: 253.9425ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:46.562858Z","caller":"traceutil/trace.go:171","msg":"trace[769672906] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"142.60418ms","start":"2026-07-23T23:52:46.420227Z","end":"2026-07-23T23:52:46.562831Z","steps":["trace[769672906] 'process raft request' (duration: 142.444967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:13.954851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370871360,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-23T23:53:14.10978Z","caller":"traceutil/trace.go:171","msg":"trace[683500060] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"805.46214ms","start":"2026-07-23T23:53:13.304291Z","end":"2026-07-23T23:53:14.109753Z","steps":["trace[683500060] 'process raft request' (duration: 805.243475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.109949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.304268Z","time spent":"805.599783ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.570178Z","caller":"traceutil/trace.go:171","msg":"trace[1921391216] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.25908376s","start":"2026-07-23T23:53:13.311058Z","end":"2026-07-23T23:53:14.570142Z","steps":["trace[1921391216] 'process raft request' (duration: 1.25866005s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:14.570221Z","caller":"traceutil/trace.go:171","msg":"trace[1045560833] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.259049839s","start":"2026-07-23T23:53:13.311133Z","end":"2026-07-23T23:53:14.570183Z","steps":["trace[1045560833] 'process raft request' (duration: 1.258921046s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.570386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.311129Z","time spent":"1.259172843s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:53:14.570392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.311039Z","time spent":"1.259217574s","remote":"127.0.0.1:44428","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-07-23T23:53:14.570533Z","caller":"traceutil/trace.go:171","msg":"trace[1882721255] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.235291183s","start":"2026-07-23T23:53:13.33522Z","end":"2026-07-23T23:53:14.570511Z","steps":["trace[1882721255] 'process raft request' (duration: 1.234964345s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:14.57055Z","caller":"traceutil/trace.go:171","msg":"trace[51965893] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.235419307s","start":"2026-07-23T23:53:13.335115Z","end":"2026-07-23T23:53:14.570534Z","steps":["trace[51965893] 'process raft request' (duration: 1.234980546s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.570599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.335098Z","time spent":"1.235477118s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:53:14.570653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.335217Z","time spent":"1.235356495s","remote":"127.0.0.1:44428","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-07-23T23:53:14.570743Z","caller":"traceutil/trace.go:171","msg":"trace[1707422906] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"1.223268856s","start":"2026-07-23T23:53:13.347465Z","end":"2026-07-23T23:53:14.570734Z","steps":["trace[1707422906] 'process raft request' (duration: 1.222755433s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:14.570781Z","caller":"traceutil/trace.go:171","msg":"trace[786570598] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"1.23559172s","start":"2026-07-23T23:53:13.335172Z","end":"2026-07-23T23:53:14.570764Z","steps":["trace[786570598] 'process raft request' (duration: 1.234957055s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.57079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.347437Z","time spent":"1.223330007s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.570782Z","caller":"traceutil/trace.go:171","msg":"trace[1311494678] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.223236205s","start":"2026-07-23T23:53:13.347507Z","end":"2026-07-23T23:53:14.570743Z","steps":["trace[1311494678] 'process raft request' (duration: 1.222790224s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.570851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.335168Z","time spent":"1.235651342s","remote":"127.0.0.1:44428","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-07-23T23:53:14.570845Z","caller":"traceutil/trace.go:171","msg":"trace[1120714258] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.211752532s","start":"2026-07-23T23:53:13.359023Z","end":"2026-07-23T23:53:14.570775Z","steps":["trace[1120714258] 'process raft request' (duration: 1.211317691s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.570891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117959606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:53:14.570923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.347462Z","time spent":"1.223394099s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.570936Z","caller":"traceutil/trace.go:171","msg":"trace[750397734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:505; }","duration":"1.118049058s","start":"2026-07-23T23:53:13.452877Z","end":"2026-07-23T23:53:14.570926Z","steps":["trace[750397734] 'agreement among raft nodes before linearized reading' (duration: 1.117955946s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:14.570966Z","caller":"traceutil/trace.go:171","msg":"trace[895928131] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.089622416s","start":"2026-07-23T23:53:13.481333Z","end":"2026-07-23T23:53:14.570956Z","steps":["trace[895928131] 'process raft request' (duration: 1.089270987s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:14.570967Z","caller":"traceutil/trace.go:171","msg":"trace[1832348907] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.201283453s","start":"2026-07-23T23:53:13.369676Z","end":"2026-07-23T23:53:14.570959Z","steps":["trace[1832348907] 'process raft request' (duration: 1.20074039s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.571013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.48131Z","time spent":"1.089682358s","remote":"127.0.0.1:44428","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-07-23T23:53:14.571018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.36966Z","time spent":"1.201338384s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.570796Z","caller":"traceutil/trace.go:171","msg":"trace[812268672] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:513; }","duration":"1.117851524s","start":"2026-07-23T23:53:13.452925Z","end":"2026-07-23T23:53:14.570777Z","steps":["trace[812268672] 'read index received' (duration: 656.759488ms)","trace[812268672] 'applied index is now lower than readState.Index' (duration: 461.091046ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:14.571025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.359002Z","time spent":"1.211928495s","remote":"127.0.0.1:44428","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-07-23T23:53:14.570935Z","caller":"traceutil/trace.go:171","msg":"trace[136654446] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.193793068s","start":"2026-07-23T23:53:13.377133Z","end":"2026-07-23T23:53:14.570926Z","steps":["trace[136654446] 'process raft request' (duration: 1.193403199s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.570973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.45286Z","time spent":"1.118106399s","remote":"127.0.0.1:44368","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-07-23T23:53:14.571099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.377117Z","time spent":"1.193965232s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.577832Z","caller":"traceutil/trace.go:171","msg":"trace[1240482112] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"462.512321ms","start":"2026-07-23T23:53:14.1153Z","end":"2026-07-23T23:53:14.577812Z","steps":["trace[1240482112] 'process raft request' (duration: 462.210063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.577932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:14.115279Z","time spent":"462.609824ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:14.578098Z","caller":"traceutil/trace.go:171","msg":"trace[1531158042] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"460.334996ms","start":"2026-07-23T23:53:14.117752Z","end":"2026-07-23T23:53:14.578087Z","steps":["trace[1531158042] 'process raft request' (duration: 459.833984ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.578162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:14.11774Z","time spent":"460.381198ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:53:14.578277Z","caller":"traceutil/trace.go:171","msg":"trace[1133060818] transaction","detail":"{read_only:false; number_of_response:1; response_revision:507; }","duration":"459.980098ms","start":"2026-07-23T23:53:14.118288Z","end":"2026-07-23T23:53:14.578268Z","steps":["trace[1133060818] 'process raft request' (duration: 459.354433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.578328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:14.118275Z","time spent":"460.023349ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:53:14.578587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027724718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:53:14.578654Z","caller":"traceutil/trace.go:171","msg":"trace[125056074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"1.027795649s","start":"2026-07-23T23:53:13.550815Z","end":"2026-07-23T23:53:14.578611Z","steps":["trace[125056074] 'agreement among raft nodes before linearized reading' (duration: 1.027738148s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.578703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.550786Z","time spent":"1.027909242s","remote":"127.0.0.1:44662","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-07-23T23:53:14.578788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028047166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:53:14.578826Z","caller":"traceutil/trace.go:171","msg":"trace[280258763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"1.028120427s","start":"2026-07-23T23:53:13.550696Z","end":"2026-07-23T23:53:14.578816Z","steps":["trace[280258763] 'agreement among raft nodes before linearized reading' (duration: 1.028019395s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.57885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.550686Z","time spent":"1.028159219s","remote":"127.0.0.1:44662","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-07-23T23:53:14.578972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033282075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:53:14.57899Z","caller":"traceutil/trace.go:171","msg":"trace[84622640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"1.033348376s","start":"2026-07-23T23:53:13.545636Z","end":"2026-07-23T23:53:14.578984Z","steps":["trace[84622640] 'agreement among raft nodes before linearized reading' (duration: 1.033314615s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.579007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.545604Z","time spent":"1.033398928s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:53:14.57909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059316428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:53:14.579106Z","caller":"traceutil/trace.go:171","msg":"trace[210996971] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:507; }","duration":"1.059363449s","start":"2026-07-23T23:53:13.519738Z","end":"2026-07-23T23:53:14.579101Z","steps":["trace[210996971] 'agreement among raft nodes before linearized reading' (duration: 1.059334468s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:14.579122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:13.519723Z","time spent":"1.059395149s","remote":"127.0.0.1:44662","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-07-23T23:53:19.667477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.660314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:53:19.667671Z","caller":"traceutil/trace.go:171","msg":"trace[1273186744] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"214.004425ms","start":"2026-07-23T23:53:19.453649Z","end":"2026-07-23T23:53:19.667654Z","steps":["trace[1273186744] 'process raft request' (duration: 213.944104ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:19.667725Z","caller":"traceutil/trace.go:171","msg":"trace[281357903] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"214.062336ms","start":"2026-07-23T23:53:19.453634Z","end":"2026-07-23T23:53:19.667696Z","steps":["trace[281357903] 'process raft request' (duration: 43.109045ms)","trace[281357903] 'compare' (duration: 170.50566ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:20.212133Z","caller":"traceutil/trace.go:171","msg":"trace[1787249873] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"368.970561ms","start":"2026-07-23T23:53:19.843137Z","end":"2026-07-23T23:53:20.212107Z","steps":["trace[1787249873] 'process raft request' (duration: 362.709576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:20.212223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:19.843115Z","time spent":"369.071144ms","remote":"127.0.0.1:44484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:20.226879Z","caller":"traceutil/trace.go:171","msg":"trace[254769046] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"123.881179ms","start":"2026-07-23T23:53:20.102976Z","end":"2026-07-23T23:53:20.226857Z","steps":["trace[254769046] 'process raft request' (duration: 123.780896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.25704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.601077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:53:21.257131Z","caller":"traceutil/trace.go:171","msg":"trace[745544726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"627.738731ms","start":"2026-07-23T23:53:20.629371Z","end":"2026-07-23T23:53:21.25711Z","steps":["trace[745544726] 'range keys from in-memory index tree' (duration: 627.382163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.257177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.629361Z","time spent":"627.807033ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.257174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.129652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:53:21.257285Z","caller":"traceutil/trace.go:171","msg":"trace[1347040971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"622.268266ms","start":"2026-07-23T23:53:20.634997Z","end":"2026-07-23T23:53:21.257266Z","steps":["trace[1347040971] 'range keys from in-memory index tree' (duration: 621.965199ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.257389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.634988Z","time spent":"622.388009ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.25747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.908305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:21.257562Z","caller":"traceutil/trace.go:171","msg":"trace[1832673421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"805.038989ms","start":"2026-07-23T23:53:20.452497Z","end":"2026-07-23T23:53:21.257536Z","steps":["trace[1832673421] 'range keys from in-memory index tree' (duration: 804.835634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.257607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.452476Z","time spent":"805.12281ms","remote":"127.0.0.1:44368","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-07-23T23:53:21.257695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.555779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:53:21.257738Z","caller":"traceutil/trace.go:171","msg":"trace[1941104661] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"632.632761ms","start":"2026-07-23T23:53:20.625095Z","end":"2026-07-23T23:53:21.257728Z","steps":["trace[1941104661] 'range keys from in-memory index tree' (duration: 632.450326ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.257765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.625077Z","time spent":"632.681382ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:53:21.257864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.371347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:53:21.257989Z","caller":"traceutil/trace.go:171","msg":"trace[909430505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"628.52749ms","start":"2026-07-23T23:53:20.629434Z","end":"2026-07-23T23:53:21.257962Z","steps":["trace[909430505] 'range keys from in-memory index tree' (duration: 628.195832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.258058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.629429Z","time spent":"628.613442ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.760766Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370871581,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-23T23:53:21.970512Z","caller":"traceutil/trace.go:171","msg":"trace[724902317] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.281412163s","start":"2026-07-23T23:53:20.689082Z","end":"2026-07-23T23:53:21.970494Z","steps":["trace[724902317] 'process raft request' (duration: 1.279860654s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.970676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:20.689061Z","time spent":"1.281521275s","remote":"127.0.0.1:44484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:53:21.970901Z","caller":"traceutil/trace.go:171","msg":"trace[52751745] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"708.635429ms","start":"2026-07-23T23:53:21.262204Z","end":"2026-07-23T23:53:21.970839Z","steps":["trace[52751745] 'process raft request' (duration: 708.225209ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:21.97102Z","caller":"traceutil/trace.go:171","msg":"trace[1664604409] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"708.722561ms","start":"2026-07-23T23:53:21.262288Z","end":"2026-07-23T23:53:21.97101Z","steps":["trace[1664604409] 'process raft request' (duration: 708.406113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.971091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:21.262263Z","time spent":"708.778632ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.971134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:21.262182Z","time spent":"708.831313ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.971538Z","caller":"traceutil/trace.go:171","msg":"trace[598736705] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:611; }","duration":"711.689264ms","start":"2026-07-23T23:53:21.259826Z","end":"2026-07-23T23:53:21.971515Z","steps":["trace[598736705] 'read index received' (duration: 707.86277ms)","trace[598736705] 'applied index is now lower than readState.Index' (duration: 3.825554ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:21.971756Z","caller":"traceutil/trace.go:171","msg":"trace[1724054362] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"709.145041ms","start":"2026-07-23T23:53:21.262596Z","end":"2026-07-23T23:53:21.971741Z","steps":["trace[1724054362] 'process raft request' (duration: 708.883814ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:21.971777Z","caller":"traceutil/trace.go:171","msg":"trace[1013082615] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"709.231613ms","start":"2026-07-23T23:53:21.262488Z","end":"2026-07-23T23:53:21.97172Z","steps":["trace[1013082615] 'process raft request' (duration: 708.930326ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.97186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:21.262572Z","time spent":"709.225783ms","remote":"127.0.0.1:44662","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-07-23T23:53:21.971898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:21.262479Z","time spent":"709.359536ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:53:21.971689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.837218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:21.97222Z","caller":"traceutil/trace.go:171","msg":"trace[494678292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"712.408851ms","start":"2026-07-23T23:53:21.2598Z","end":"2026-07-23T23:53:21.972208Z","steps":["trace[494678292] 'agreement among raft nodes before linearized reading' (duration: 711.807166ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:21.972254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:21.259784Z","time spent":"712.460493ms","remote":"127.0.0.1:44356","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-07-23T23:53:22.682756Z","caller":"traceutil/trace.go:171","msg":"trace[180607188] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"229.003745ms","start":"2026-07-23T23:53:22.453726Z","end":"2026-07-23T23:53:22.68273Z","steps":["trace[180607188] 'read index received' (duration: 227.96798ms)","trace[180607188] 'applied index is now lower than readState.Index' (duration: 1.034785ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:22.682853Z","caller":"traceutil/trace.go:171","msg":"trace[2055455415] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"235.590247ms","start":"2026-07-23T23:53:22.447222Z","end":"2026-07-23T23:53:22.682812Z","steps":["trace[2055455415] 'process raft request' (duration: 234.670875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:22.682929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.170679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:22.683018Z","caller":"traceutil/trace.go:171","msg":"trace[1596472215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"229.297472ms","start":"2026-07-23T23:53:22.453695Z","end":"2026-07-23T23:53:22.682993Z","steps":["trace[1596472215] 'agreement among raft nodes before linearized reading' (duration: 229.129478ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:22.683063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.925186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pwkdb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-23T23:53:22.68324Z","caller":"traceutil/trace.go:171","msg":"trace[252453161] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pwkdb; range_end:; response_count:1; response_revision:597; }","duration":"181.07287ms","start":"2026-07-23T23:53:22.50209Z","end":"2026-07-23T23:53:22.683163Z","steps":["trace[252453161] 'agreement among raft nodes before linearized reading' (duration: 180.784803ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:23.419933Z","caller":"traceutil/trace.go:171","msg":"trace[1766889509] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"715.004746ms","start":"2026-07-23T23:53:22.704898Z","end":"2026-07-23T23:53:23.419903Z","steps":["trace[1766889509] 'process raft request' (duration: 714.719569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:23.420442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:22.704867Z","time spent":"715.248831ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:53:25.453288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00016551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-23T23:53:25.45338Z","caller":"traceutil/trace.go:171","msg":"trace[746703044] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000306614s","start":"2026-07-23T23:53:23.453051Z","end":"2026-07-23T23:53:25.453358Z","steps":["trace[746703044] 'agreement among raft nodes before linearized reading' (duration: 2.000193411s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.453447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:23.45303Z","time spent":"2.000402296s","remote":"127.0.0.1:44368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/23 23:53:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-23T23:53:25.672019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.774709ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:25.672149Z","caller":"traceutil/trace.go:171","msg":"trace[188178105] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:598; }","duration":"215.929332ms","start":"2026-07-23T23:53:25.456203Z","end":"2026-07-23T23:53:25.672132Z","steps":["trace[188178105] 'range keys from in-memory index tree' (duration: 215.758258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.697815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.19657935s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-23T23:53:25.698066Z","caller":"traceutil/trace.go:171","msg":"trace[494367766] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"2.244950724s","start":"2026-07-23T23:53:23.453096Z","end":"2026-07-23T23:53:25.698046Z","steps":["trace[494367766] 'read index received' (duration: 48.069496ms)","trace[494367766] 'applied index is now lower than readState.Index' (duration: 2.196880158s)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:25.698115Z","caller":"traceutil/trace.go:171","msg":"trace[1364113542] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"2.958094154s","start":"2026-07-23T23:53:22.739971Z","end":"2026-07-23T23:53:25.698065Z","steps":["trace[1364113542] 'process raft request' (duration: 2.95792242s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.698292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:22.739947Z","time spent":"2.958280339s","remote":"127.0.0.1:44718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:53:25.698306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208444331s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:25.698384Z","caller":"traceutil/trace.go:171","msg":"trace[936895938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.208572594s","start":"2026-07-23T23:53:24.489792Z","end":"2026-07-23T23:53:25.698364Z","steps":["trace[936895938] 'agreement among raft nodes before linearized reading' (duration: 1.208387078s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.69842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722384141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-23T23:53:25.698426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:24.489766Z","time spent":"1.208651426s","remote":"127.0.0.1:44368","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-07-23T23:53:25.698421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722129145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:53:25.698454Z","caller":"traceutil/trace.go:171","msg":"trace[65753839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"1.722413422s","start":"2026-07-23T23:53:23.97603Z","end":"2026-07-23T23:53:25.698443Z","steps":["trace[65753839] 'agreement among raft nodes before linearized reading' (duration: 1.72233065s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.69842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722115494s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-23T23:53:25.698495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:23.975977Z","time spent":"1.722510494s","remote":"127.0.0.1:44662","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-07-23T23:53:25.698491Z","caller":"traceutil/trace.go:171","msg":"trace[581603186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"1.722225937s","start":"2026-07-23T23:53:23.976245Z","end":"2026-07-23T23:53:25.698471Z","steps":["trace[581603186] 'agreement among raft nodes before linearized reading' (duration: 1.722006662s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:25.698529Z","caller":"traceutil/trace.go:171","msg":"trace[643130972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"1.722265608s","start":"2026-07-23T23:53:23.976244Z","end":"2026-07-23T23:53:25.698509Z","steps":["trace[643130972] 'agreement among raft nodes before linearized reading' (duration: 1.721999632s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.698544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:23.976228Z","time spent":"1.722305329s","remote":"127.0.0.1:44662","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-07-23T23:53:25.698337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.723441798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-23T23:53:25.698575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:23.97623Z","time spent":"1.72233506s","remote":"127.0.0.1:44662","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-07-23T23:53:25.698598Z","caller":"traceutil/trace.go:171","msg":"trace[1175619917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"1.723741275s","start":"2026-07-23T23:53:23.974844Z","end":"2026-07-23T23:53:25.698585Z","steps":["trace[1175619917] 'agreement among raft nodes before linearized reading' (duration: 1.723318514s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:25.69869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:23.974824Z","time spent":"1.723849427s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:53:25.698716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.95893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:25.698761Z","caller":"traceutil/trace.go:171","msg":"trace[1975268840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"245.032191ms","start":"2026-07-23T23:53:25.453716Z","end":"2026-07-23T23:53:25.698748Z","steps":["trace[1975268840] 'agreement among raft nodes before linearized reading' (duration: 244.966569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:26.733469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.58691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:53:26.733575Z","caller":"traceutil/trace.go:171","msg":"trace[366375879] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"144.251732ms","start":"2026-07-23T23:53:26.589305Z","end":"2026-07-23T23:53:26.733557Z","steps":["trace[366375879] 'process raft request' (duration: 33.514818ms)","trace[366375879] 'compare' (duration: 110.465648ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:27.676329Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052271214s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T23:53:27.683505Z","caller":"traceutil/trace.go:171","msg":"trace[1607651924] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.074281007s","start":"2026-07-23T23:53:26.609189Z","end":"2026-07-23T23:53:27.68347Z","steps":["trace[1607651924] 'process raft request' (duration: 1.067837008s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:27.683726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:26.609164Z","time spent":"1.07443697s","remote":"127.0.0.1:44484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:53:27.684591Z","caller":"traceutil/trace.go:171","msg":"trace[40681315] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"231.303822ms","start":"2026-07-23T23:53:27.453245Z","end":"2026-07-23T23:53:27.684549Z","steps":["trace[40681315] 'read index received' (duration: 223.389117ms)","trace[40681315] 'applied index is now lower than readState.Index' (duration: 7.912925ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:27.684727Z","caller":"traceutil/trace.go:171","msg":"trace[1047704652] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"629.605057ms","start":"2026-07-23T23:53:27.055107Z","end":"2026-07-23T23:53:27.684712Z","steps":["trace[1047704652] 'process raft request' (duration: 629.246338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:27.684939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.805565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pwkdb\" ","response":"range_response_count:1 size:17247"} {"level":"warn","ts":"2026-07-23T23:53:27.684948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:27.055077Z","time spent":"629.697599ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:53:27.685033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.672034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-23T23:53:27.685117Z","caller":"traceutil/trace.go:171","msg":"trace[192806655] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:612; }","duration":"140.761576ms","start":"2026-07-23T23:53:27.54434Z","end":"2026-07-23T23:53:27.685101Z","steps":["trace[192806655] 'agreement among raft nodes before linearized reading' (duration: 140.575201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:27.68497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.724762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:27.685201Z","caller":"traceutil/trace.go:171","msg":"trace[126601777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"232.003449ms","start":"2026-07-23T23:53:27.453189Z","end":"2026-07-23T23:53:27.685192Z","steps":["trace[126601777] 'agreement among raft nodes before linearized reading' (duration: 231.710972ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:27.685005Z","caller":"traceutil/trace.go:171","msg":"trace[90695109] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pwkdb; range_end:; response_count:1; response_revision:612; }","duration":"165.903237ms","start":"2026-07-23T23:53:27.519084Z","end":"2026-07-23T23:53:27.684987Z","steps":["trace[90695109] 'agreement among raft nodes before linearized reading' (duration: 165.741953ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:27.816492Z","caller":"traceutil/trace.go:171","msg":"trace[1974934567] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"115.155703ms","start":"2026-07-23T23:53:27.701293Z","end":"2026-07-23T23:53:27.816449Z","steps":["trace[1974934567] 'process raft request' (duration: 81.40814ms)","trace[1974934567] 'compare' (duration: 33.453406ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:27.816766Z","caller":"traceutil/trace.go:171","msg":"trace[1491447293] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"103.487466ms","start":"2026-07-23T23:53:27.713066Z","end":"2026-07-23T23:53:27.816553Z","steps":["trace[1491447293] 'read index received' (duration: 46.070738ms)","trace[1491447293] 'applied index is now lower than readState.Index' (duration: 57.415218ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:27.81716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.807143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:53:27.817328Z","caller":"traceutil/trace.go:171","msg":"trace[866473612] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"103.958317ms","start":"2026-07-23T23:53:27.713327Z","end":"2026-07-23T23:53:27.817285Z","steps":["trace[866473612] 'agreement among raft nodes before linearized reading' (duration: 103.6821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:27.817388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.360238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:53:27.817471Z","caller":"traceutil/trace.go:171","msg":"trace[1451750359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"102.445861ms","start":"2026-07-23T23:53:27.715004Z","end":"2026-07-23T23:53:27.817449Z","steps":["trace[1451750359] 'agreement among raft nodes before linearized reading' (duration: 102.317897ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:27.817617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.351242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-23T23:53:27.817161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.06297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:53:27.817675Z","caller":"traceutil/trace.go:171","msg":"trace[327696837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"103.432135ms","start":"2026-07-23T23:53:27.714227Z","end":"2026-07-23T23:53:27.817659Z","steps":["trace[327696837] 'agreement among raft nodes before linearized reading' (duration: 103.156568ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:27.817753Z","caller":"traceutil/trace.go:171","msg":"trace[1662256638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"104.693625ms","start":"2026-07-23T23:53:27.713047Z","end":"2026-07-23T23:53:27.817741Z","steps":["trace[1662256638] 'agreement among raft nodes before linearized reading' (duration: 103.931086ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:31.814268Z","caller":"traceutil/trace.go:171","msg":"trace[1586736787] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"139.522685ms","start":"2026-07-23T23:53:31.674719Z","end":"2026-07-23T23:53:31.814241Z","steps":["trace[1586736787] 'process raft request' (duration: 138.893129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:42.545236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.913094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T23:53:42.545314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.990985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:53:42.54533Z","caller":"traceutil/trace.go:171","msg":"trace[830744161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:776; }","duration":"570.031327ms","start":"2026-07-23T23:53:41.975278Z","end":"2026-07-23T23:53:42.545309Z","steps":["trace[830744161] 'range keys from in-memory index tree' (duration: 569.787391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:42.545365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:41.975266Z","time spent":"570.089879ms","remote":"127.0.0.1:44662","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-07-23T23:53:42.545376Z","caller":"traceutil/trace.go:171","msg":"trace[1585735656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"640.099307ms","start":"2026-07-23T23:53:41.905251Z","end":"2026-07-23T23:53:42.545351Z","steps":["trace[1585735656] 'range keys from in-memory index tree' (duration: 639.710098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:42.54542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:41.905222Z","time spent":"640.190169ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:53:42.545238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.884503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:53:42.545532Z","caller":"traceutil/trace.go:171","msg":"trace[1261454185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:776; }","duration":"589.238862ms","start":"2026-07-23T23:53:41.956283Z","end":"2026-07-23T23:53:42.545522Z","steps":["trace[1261454185] 'range keys from in-memory index tree' (duration: 588.717709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:42.545559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:41.956261Z","time spent":"589.291213ms","remote":"127.0.0.1:44662","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-07-23T23:53:42.546142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.260031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:53:42.546319Z","caller":"traceutil/trace.go:171","msg":"trace[739921065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:776; }","duration":"597.478077ms","start":"2026-07-23T23:53:41.948819Z","end":"2026-07-23T23:53:42.546297Z","steps":["trace[739921065] 'range keys from in-memory index tree' (duration: 596.43946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:42.54638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:41.948797Z","time spent":"597.573499ms","remote":"127.0.0.1:44662","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-07-23T23:53:42.831329Z","caller":"traceutil/trace.go:171","msg":"trace[401819676] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"282.459469ms","start":"2026-07-23T23:53:42.54884Z","end":"2026-07-23T23:53:42.831299Z","steps":["trace[401819676] 'process raft request' (duration: 282.238454ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:42.83415Z","caller":"traceutil/trace.go:171","msg":"trace[2137399132] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"284.324607ms","start":"2026-07-23T23:53:42.549788Z","end":"2026-07-23T23:53:42.834112Z","steps":["trace[2137399132] 'process raft request' (duration: 284.207864ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:42.834682Z","caller":"traceutil/trace.go:171","msg":"trace[1351440460] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"285.61882ms","start":"2026-07-23T23:53:42.548979Z","end":"2026-07-23T23:53:42.834597Z","steps":["trace[1351440460] 'process raft request' (duration: 284.759557ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:42.834865Z","caller":"traceutil/trace.go:171","msg":"trace[848119086] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"161.380226ms","start":"2026-07-23T23:53:42.673452Z","end":"2026-07-23T23:53:42.834833Z","steps":["trace[848119086] 'process raft request' (duration: 160.882623ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:42.834953Z","caller":"traceutil/trace.go:171","msg":"trace[833763121] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"285.022355ms","start":"2026-07-23T23:53:42.549907Z","end":"2026-07-23T23:53:42.834929Z","steps":["trace[833763121] 'process raft request' (duration: 284.134272ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:42.843213Z","caller":"traceutil/trace.go:171","msg":"trace[234914593] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:806; }","duration":"193.686473ms","start":"2026-07-23T23:53:42.649504Z","end":"2026-07-23T23:53:42.843191Z","steps":["trace[234914593] 'read index received' (duration: 181.525314ms)","trace[234914593] 'applied index is now lower than readState.Index' (duration: 12.160029ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:42.843402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.885867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-23T23:53:42.843443Z","caller":"traceutil/trace.go:171","msg":"trace[2001670423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"193.997321ms","start":"2026-07-23T23:53:42.649437Z","end":"2026-07-23T23:53:42.843435Z","steps":["trace[2001670423] 'agreement among raft nodes before linearized reading' (duration: 193.836507ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:53.057572Z","caller":"traceutil/trace.go:171","msg":"trace[203287853] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:926; }","duration":"160.230346ms","start":"2026-07-23T23:53:52.897321Z","end":"2026-07-23T23:53:53.057552Z","steps":["trace[203287853] 'read index received' (duration: 159.972799ms)","trace[203287853] 'applied index is now lower than readState.Index' (duration: 256.367µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:53.05762Z","caller":"traceutil/trace.go:171","msg":"trace[1982443542] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"164.421873ms","start":"2026-07-23T23:53:52.89317Z","end":"2026-07-23T23:53:53.057591Z","steps":["trace[1982443542] 'process raft request' (duration: 164.224308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:53.057794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.463452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:53:53.057829Z","caller":"traceutil/trace.go:171","msg":"trace[1582294337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:894; }","duration":"160.560564ms","start":"2026-07-23T23:53:52.897259Z","end":"2026-07-23T23:53:53.05782Z","steps":["trace[1582294337] 'agreement among raft nodes before linearized reading' (duration: 160.412421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:53.05789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.00362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:53:53.057951Z","caller":"traceutil/trace.go:171","msg":"trace[579666113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:894; }","duration":"160.093962ms","start":"2026-07-23T23:53:52.897839Z","end":"2026-07-23T23:53:53.057933Z","steps":["trace[579666113] 'agreement among raft nodes before linearized reading' (duration: 159.873827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:53.058004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.247707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:53:53.058087Z","caller":"traceutil/trace.go:171","msg":"trace[689105349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:894; }","duration":"128.4007ms","start":"2026-07-23T23:53:52.929669Z","end":"2026-07-23T23:53:53.05807Z","steps":["trace[689105349] 'agreement among raft nodes before linearized reading' (duration: 128.107993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:53.058599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.283347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-23T23:53:53.058667Z","caller":"traceutil/trace.go:171","msg":"trace[999987090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:894; }","duration":"128.373099ms","start":"2026-07-23T23:53:52.930284Z","end":"2026-07-23T23:53:53.058657Z","steps":["trace[999987090] 'agreement among raft nodes before linearized reading' (duration: 127.967889ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:19.133322Z","caller":"traceutil/trace.go:171","msg":"trace[268419569] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"187.823865ms","start":"2026-07-23T23:54:18.945476Z","end":"2026-07-23T23:54:19.1333Z","steps":["trace[268419569] 'process raft request' (duration: 187.6528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:19.764047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.333188ms","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-07-23T23:54:19.764139Z","caller":"traceutil/trace.go:171","msg":"trace[235797301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:995; }","duration":"559.44989ms","start":"2026-07-23T23:54:19.204665Z","end":"2026-07-23T23:54:19.764115Z","steps":["trace[235797301] 'range keys from in-memory index tree' (duration: 559.156773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:19.764146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.434754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-23T23:54:19.764194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.204657Z","time spent":"559.514543ms","remote":"127.0.0.1:44662","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":"info","ts":"2026-07-23T23:54:19.764224Z","caller":"traceutil/trace.go:171","msg":"trace[120339794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"565.546937ms","start":"2026-07-23T23:54:19.198657Z","end":"2026-07-23T23:54:19.764204Z","steps":["trace[120339794] 'range keys from in-memory index tree' (duration: 565.263799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:19.764211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.078663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-23T23:54:19.764267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.198608Z","time spent":"565.650659ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:54:19.764253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.073149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-23T23:54:19.764309Z","caller":"traceutil/trace.go:171","msg":"trace[617517458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:995; }","duration":"563.202886ms","start":"2026-07-23T23:54:19.201061Z","end":"2026-07-23T23:54:19.764264Z","steps":["trace[617517458] 'range keys from in-memory index tree' (duration: 562.926019ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:19.764317Z","caller":"traceutil/trace.go:171","msg":"trace[1620603438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:995; }","duration":"551.169931ms","start":"2026-07-23T23:54:19.213131Z","end":"2026-07-23T23:54:19.764301Z","steps":["trace[1620603438] 'range keys from in-memory index tree' (duration: 550.841383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:19.764144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.456502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-23T23:54:19.764359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.213116Z","time spent":"551.231573ms","remote":"127.0.0.1:44662","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-07-23T23:54:19.764378Z","caller":"traceutil/trace.go:171","msg":"trace[87895453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"595.74979ms","start":"2026-07-23T23:54:19.168619Z","end":"2026-07-23T23:54:19.764369Z","steps":["trace[87895453] 'range keys from in-memory index tree' (duration: 595.281008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:19.764379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.201039Z","time spent":"563.305019ms","remote":"127.0.0.1:44662","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":"warn","ts":"2026-07-23T23:54:19.764404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.168599Z","time spent":"595.798761ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-23T23:54:20.01595Z","caller":"traceutil/trace.go:171","msg":"trace[161032487] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"247.855654ms","start":"2026-07-23T23:54:19.768073Z","end":"2026-07-23T23:54:20.015929Z","steps":["trace[161032487] 'process raft request' (duration: 247.70691ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:20.089485Z","caller":"traceutil/trace.go:171","msg":"trace[2046685221] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"321.17898ms","start":"2026-07-23T23:54:19.768282Z","end":"2026-07-23T23:54:20.089461Z","steps":["trace[2046685221] 'process raft request' (duration: 320.971084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:20.089616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.76826Z","time spent":"321.291342ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:54:20.089744Z","caller":"traceutil/trace.go:171","msg":"trace[19886866] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"321.386364ms","start":"2026-07-23T23:54:19.768329Z","end":"2026-07-23T23:54:20.089716Z","steps":["trace[19886866] 'process raft request' (duration: 321.094737ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:20.089824Z","caller":"traceutil/trace.go:171","msg":"trace[1246225927] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"321.366814ms","start":"2026-07-23T23:54:19.768437Z","end":"2026-07-23T23:54:20.089803Z","steps":["trace[1246225927] 'process raft request' (duration: 321.18388ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:20.089883Z","caller":"traceutil/trace.go:171","msg":"trace[268263336] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1034; }","duration":"185.478036ms","start":"2026-07-23T23:54:19.904394Z","end":"2026-07-23T23:54:20.089872Z","steps":["trace[268263336] 'read index received' (duration: 111.447632ms)","trace[268263336] 'applied index is now lower than readState.Index' (duration: 74.029714ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:54:20.089892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.768317Z","time spent":"321.488777ms","remote":"127.0.0.1:44662","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-07-23T23:54:20.089936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.768428Z","time spent":"321.446137ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:54:20.090034Z","caller":"traceutil/trace.go:171","msg":"trace[77183497] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"262.2744ms","start":"2026-07-23T23:54:19.827754Z","end":"2026-07-23T23:54:20.090028Z","steps":["trace[77183497] 'process raft request' (duration: 262.080325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:20.089983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.592758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:54:20.090103Z","caller":"traceutil/trace.go:171","msg":"trace[782667925] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1001; }","duration":"185.735602ms","start":"2026-07-23T23:54:19.904343Z","end":"2026-07-23T23:54:20.090078Z","steps":["trace[782667925] 'agreement among raft nodes before linearized reading' (duration: 185.578278ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:20.090012Z","caller":"traceutil/trace.go:171","msg":"trace[975718941] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"321.57143ms","start":"2026-07-23T23:54:19.768433Z","end":"2026-07-23T23:54:20.090005Z","steps":["trace[975718941] 'process raft request' (duration: 321.316253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:20.090254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:19.768414Z","time spent":"321.796615ms","remote":"127.0.0.1:44662","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-07-23T23:54:39.493866Z","caller":"traceutil/trace.go:171","msg":"trace[1009830183] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"120.024318ms","start":"2026-07-23T23:54:39.373805Z","end":"2026-07-23T23:54:39.49383Z","steps":["trace[1009830183] 'process raft request' (duration: 119.753881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:42.612955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370872622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:54:43.113987Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370872622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:54:43.395598Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.355082382s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T23:54:43.39606Z","caller":"traceutil/trace.go:171","msg":"trace[1494427877] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"1.355655206s","start":"2026-07-23T23:54:42.04038Z","end":"2026-07-23T23:54:43.396035Z","steps":["trace[1494427877] 'process raft request' (duration: 1.355506232s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.396216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.04035Z","time spent":"1.355770499s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:54:43.477329Z","caller":"traceutil/trace.go:171","msg":"trace[774934057] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"1.298763546s","start":"2026-07-23T23:54:42.178539Z","end":"2026-07-23T23:54:43.477302Z","steps":["trace[774934057] 'process raft request' (duration: 1.27481239s)","trace[774934057] 'compare' (duration: 23.805882ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:54:43.477493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.178515Z","time spent":"1.29889165s","remote":"127.0.0.1:44662","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-07-23T23:54:43.504715Z","caller":"traceutil/trace.go:171","msg":"trace[850829426] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1110; }","duration":"1.392404806s","start":"2026-07-23T23:54:42.112282Z","end":"2026-07-23T23:54:43.504687Z","steps":["trace[850829426] 'read index received' (duration: 1.283594392s)","trace[850829426] 'applied index is now lower than readState.Index' (duration: 108.808824ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:54:43.504909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3518208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:54:43.50493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392642942s","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-07-23T23:54:43.504951Z","caller":"traceutil/trace.go:171","msg":"trace[1658297306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1069; }","duration":"1.351918652s","start":"2026-07-23T23:54:42.153021Z","end":"2026-07-23T23:54:43.50494Z","steps":["trace[1658297306] 'agreement among raft nodes before linearized reading' (duration: 1.351823779s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:43.504979Z","caller":"traceutil/trace.go:171","msg":"trace[1655852475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1069; }","duration":"1.392740904s","start":"2026-07-23T23:54:42.112225Z","end":"2026-07-23T23:54:43.504966Z","steps":["trace[1655852475] 'agreement among raft nodes before linearized reading' (duration: 1.39257237s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.50499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.152999Z","time spent":"1.351980634s","remote":"127.0.0.1:52214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:54:43.505043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.1122Z","time spent":"1.392815427s","remote":"127.0.0.1:44662","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-07-23T23:54:43.505182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.152645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:54:43.505204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053721033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:54:43.505229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.975839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:54:43.505245Z","caller":"traceutil/trace.go:171","msg":"trace[442766047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"1.053762724s","start":"2026-07-23T23:54:42.451471Z","end":"2026-07-23T23:54:43.505234Z","steps":["trace[442766047] 'agreement among raft nodes before linearized reading' (duration: 1.053692512s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:43.505244Z","caller":"traceutil/trace.go:171","msg":"trace[1263781510] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1069; }","duration":"926.276477ms","start":"2026-07-23T23:54:42.578954Z","end":"2026-07-23T23:54:43.505231Z","steps":["trace[1263781510] 'agreement among raft nodes before linearized reading' (duration: 926.095502ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.505281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.451412Z","time spent":"1.053863566s","remote":"127.0.0.1:44368","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-07-23T23:54:43.505281Z","caller":"traceutil/trace.go:171","msg":"trace[467494033] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1069; }","duration":"621.064882ms","start":"2026-07-23T23:54:42.884203Z","end":"2026-07-23T23:54:43.505268Z","steps":["trace[467494033] 'agreement among raft nodes before linearized reading' (duration: 620.873587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.505324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.884182Z","time spent":"621.130363ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:54:43.505315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307150269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-23T23:54:43.505322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.308636406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-23T23:54:43.505395Z","caller":"traceutil/trace.go:171","msg":"trace[516621143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1069; }","duration":"1.308729218s","start":"2026-07-23T23:54:42.196653Z","end":"2026-07-23T23:54:43.505382Z","steps":["trace[516621143] 'agreement among raft nodes before linearized reading' (duration: 1.308574394s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:54:43.50539Z","caller":"traceutil/trace.go:171","msg":"trace[1371176369] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1069; }","duration":"1.307251021s","start":"2026-07-23T23:54:42.19812Z","end":"2026-07-23T23:54:43.505371Z","steps":["trace[1371176369] 'agreement among raft nodes before linearized reading' (duration: 1.307091688s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.50543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.196642Z","time spent":"1.30878142s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:54:43.505391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30011347s","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":"warn","ts":"2026-07-23T23:54:43.505444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.198105Z","time spent":"1.307330073s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:54:43.50554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305919457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-23T23:54:43.505554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.578935Z","time spent":"926.346379ms","remote":"127.0.0.1:44648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:54:43.505602Z","caller":"traceutil/trace.go:171","msg":"trace[51536567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1069; }","duration":"1.305998989s","start":"2026-07-23T23:54:42.19958Z","end":"2026-07-23T23:54:43.505579Z","steps":["trace[51536567] 'agreement among raft nodes before linearized reading' (duration: 1.305814714s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.505637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.19957Z","time spent":"1.306060001s","remote":"127.0.0.1:44662","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-07-23T23:54:43.505491Z","caller":"traceutil/trace.go:171","msg":"trace[732811498] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1069; }","duration":"1.300480379s","start":"2026-07-23T23:54:42.204995Z","end":"2026-07-23T23:54:43.505476Z","steps":["trace[732811498] 'agreement among raft nodes before linearized reading' (duration: 1.299877194s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:43.507219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:54:42.204985Z","time spent":"1.302201793s","remote":"127.0.0.1:44662","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-07-23T23:54:45.676936Z","caller":"traceutil/trace.go:171","msg":"trace[1748161224] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"138.950097ms","start":"2026-07-23T23:54:45.537952Z","end":"2026-07-23T23:54:45.676902Z","steps":["trace[1748161224] 'read index received' (duration: 138.625029ms)","trace[1748161224] 'applied index is now lower than readState.Index' (duration: 323.628µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:54:45.677022Z","caller":"traceutil/trace.go:171","msg":"trace[1120927214] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"194.655897ms","start":"2026-07-23T23:54:45.482335Z","end":"2026-07-23T23:54:45.676991Z","steps":["trace[1120927214] 'process raft request' (duration: 194.37364ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:54:45.677293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.321046ms","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-07-23T23:54:45.677411Z","caller":"traceutil/trace.go:171","msg":"trace[323890927] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1075; }","duration":"139.492421ms","start":"2026-07-23T23:54:45.5379Z","end":"2026-07-23T23:54:45.677393Z","steps":["trace[323890927] 'agreement among raft nodes before linearized reading' (duration: 139.194683ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:01.834857Z","caller":"traceutil/trace.go:171","msg":"trace[1408010863] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"107.44608ms","start":"2026-07-23T23:55:01.72738Z","end":"2026-07-23T23:55:01.834826Z","steps":["trace[1408010863] 'process raft request' (duration: 107.164094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.34341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.433691ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-23T23:55:04.343646Z","caller":"traceutil/trace.go:171","msg":"trace[1745659314] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1233; }","duration":"890.18236ms","start":"2026-07-23T23:55:03.453406Z","end":"2026-07-23T23:55:04.343589Z","steps":["trace[1745659314] 'read index received' (duration: 302.592775ms)","trace[1745659314] 'applied index is now lower than readState.Index' (duration: 587.588705ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:04.344177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.775044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:04.344237Z","caller":"traceutil/trace.go:171","msg":"trace[484719397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1184; }","duration":"890.884377ms","start":"2026-07-23T23:55:03.453334Z","end":"2026-07-23T23:55:04.344218Z","steps":["trace[484719397] 'agreement among raft nodes before linearized reading' (duration: 890.775744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.344272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.45331Z","time spent":"890.955439ms","remote":"127.0.0.1:44368","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-07-23T23:55:04.344596Z","caller":"traceutil/trace.go:171","msg":"trace[298266995] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"678.332791ms","start":"2026-07-23T23:55:03.666255Z","end":"2026-07-23T23:55:04.344588Z","steps":["trace[298266995] 'process raft request' (duration: 677.250985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.344663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.666235Z","time spent":"678.381672ms","remote":"127.0.0.1:44662","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-07-23T23:55:04.354639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.311681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:55:04.354685Z","caller":"traceutil/trace.go:171","msg":"trace[1889074582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1186; }","duration":"495.432904ms","start":"2026-07-23T23:55:03.859234Z","end":"2026-07-23T23:55:04.354667Z","steps":["trace[1889074582] 'agreement among raft nodes before linearized reading' (duration: 495.311821ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:04.354675Z","caller":"traceutil/trace.go:171","msg":"trace[700868705] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"512.911847ms","start":"2026-07-23T23:55:03.841732Z","end":"2026-07-23T23:55:04.354643Z","steps":["trace[700868705] 'process raft request' (duration: 502.848283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.354712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.859202Z","time spent":"495.503275ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:55:04.354702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.89443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T23:55:04.354739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.185369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:55:04.354794Z","caller":"traceutil/trace.go:171","msg":"trace[1830831485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1186; }","duration":"500.269351ms","start":"2026-07-23T23:55:03.854508Z","end":"2026-07-23T23:55:04.354778Z","steps":["trace[1830831485] 'agreement among raft nodes before linearized reading' (duration: 500.060066ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.354807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.841711Z","time spent":"513.01491ms","remote":"127.0.0.1:44662","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-07-23T23:55:04.354812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.508602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:55:04.354833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.977313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-23T23:55:04.35486Z","caller":"traceutil/trace.go:171","msg":"trace[1790836856] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1186; }","duration":"380.593693ms","start":"2026-07-23T23:55:03.974257Z","end":"2026-07-23T23:55:04.35485Z","steps":["trace[1790836856] 'agreement among raft nodes before linearized reading' (duration: 380.527172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.35487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.602478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:55:04.35489Z","caller":"traceutil/trace.go:171","msg":"trace[1314476685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1186; }","duration":"495.641038ms","start":"2026-07-23T23:55:03.859244Z","end":"2026-07-23T23:55:04.354885Z","steps":["trace[1314476685] 'agreement among raft nodes before linearized reading' (duration: 495.31342ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.354891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.974237Z","time spent":"380.647215ms","remote":"127.0.0.1:45090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:55:04.354914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.859233Z","time spent":"495.67591ms","remote":"127.0.0.1:44662","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-07-23T23:55:04.354869Z","caller":"traceutil/trace.go:171","msg":"trace[421709510] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1186; }","duration":"495.027994ms","start":"2026-07-23T23:55:03.859834Z","end":"2026-07-23T23:55:04.354862Z","steps":["trace[421709510] 'agreement among raft nodes before linearized reading' (duration: 494.949282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.355079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.859805Z","time spent":"495.26662ms","remote":"127.0.0.1:44662","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-07-23T23:55:04.354751Z","caller":"traceutil/trace.go:171","msg":"trace[1844673060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1186; }","duration":"494.951252ms","start":"2026-07-23T23:55:03.859786Z","end":"2026-07-23T23:55:04.354738Z","steps":["trace[1844673060] 'agreement among raft nodes before linearized reading' (duration: 494.801708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:04.355195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.859753Z","time spent":"495.432233ms","remote":"127.0.0.1:44662","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-07-23T23:55:04.354825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:03.854495Z","time spent":"500.322212ms","remote":"127.0.0.1:44662","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-07-23T23:55:18.952033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370872995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:55:19.208255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.379186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:55:19.20835Z","caller":"traceutil/trace.go:171","msg":"trace[791637368] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1285; }","duration":"757.384514ms","start":"2026-07-23T23:55:18.45095Z","end":"2026-07-23T23:55:19.208334Z","steps":["trace[791637368] 'read index received' (duration: 557.809293ms)","trace[791637368] 'applied index is now lower than readState.Index' (duration: 199.573671ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:55:19.208603Z","caller":"traceutil/trace.go:171","msg":"trace[1423960943] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"762.719164ms","start":"2026-07-23T23:55:18.445864Z","end":"2026-07-23T23:55:19.208583Z","steps":["trace[1423960943] 'process raft request' (duration: 562.940918ms)","trace[1423960943] 'compare' (duration: 198.943896ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:19.208685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.445848Z","time spent":"762.800636ms","remote":"127.0.0.1:44662","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-07-23T23:55:19.208998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.03837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T23:55:19.209046Z","caller":"traceutil/trace.go:171","msg":"trace[597747605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"758.126733ms","start":"2026-07-23T23:55:18.450906Z","end":"2026-07-23T23:55:19.209033Z","steps":["trace[597747605] 'agreement among raft nodes before linearized reading' (duration: 757.99092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:19.209083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.450887Z","time spent":"758.188395ms","remote":"127.0.0.1:44662","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-07-23T23:55:19.210276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.783615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:55:19.210405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.762566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:19.210406Z","caller":"traceutil/trace.go:171","msg":"trace[1680481982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1233; }","duration":"757.945829ms","start":"2026-07-23T23:55:18.452441Z","end":"2026-07-23T23:55:19.210386Z","steps":["trace[1680481982] 'agreement among raft nodes before linearized reading' (duration: 757.767955ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:19.210445Z","caller":"traceutil/trace.go:171","msg":"trace[1629014090] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1233; }","duration":"130.851528ms","start":"2026-07-23T23:55:19.079581Z","end":"2026-07-23T23:55:19.210433Z","steps":["trace[1629014090] 'agreement among raft nodes before linearized reading' (duration: 130.792877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:19.210463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.612257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-23T23:55:19.210472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.150718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:55:19.210547Z","caller":"traceutil/trace.go:171","msg":"trace[844806656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1233; }","duration":"231.72607ms","start":"2026-07-23T23:55:18.978783Z","end":"2026-07-23T23:55:19.210509Z","steps":["trace[844806656] 'agreement among raft nodes before linearized reading' (duration: 231.618758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:19.210327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.381444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:55:19.210661Z","caller":"traceutil/trace.go:171","msg":"trace[217394144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1233; }","duration":"759.762763ms","start":"2026-07-23T23:55:18.450887Z","end":"2026-07-23T23:55:19.21065Z","steps":["trace[217394144] 'agreement among raft nodes before linearized reading' (duration: 759.305693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:19.210611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.964988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-23T23:55:19.210746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.26984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:19.210771Z","caller":"traceutil/trace.go:171","msg":"trace[1552923636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"722.141892ms","start":"2026-07-23T23:55:18.488602Z","end":"2026-07-23T23:55:19.210743Z","steps":["trace[1552923636] 'agreement among raft nodes before linearized reading' (duration: 721.899736ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:19.210551Z","caller":"traceutil/trace.go:171","msg":"trace[183803869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"721.262041ms","start":"2026-07-23T23:55:18.489271Z","end":"2026-07-23T23:55:19.210533Z","steps":["trace[183803869] 'agreement among raft nodes before linearized reading' (duration: 721.015565ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:19.21079Z","caller":"traceutil/trace.go:171","msg":"trace[1057369981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1233; }","duration":"728.346882ms","start":"2026-07-23T23:55:18.482433Z","end":"2026-07-23T23:55:19.210779Z","steps":["trace[1057369981] 'agreement among raft nodes before linearized reading' (duration: 728.27354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:19.210766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.450861Z","time spent":"759.859256ms","remote":"127.0.0.1:44662","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-07-23T23:55:19.210824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.489263Z","time spent":"721.549178ms","remote":"127.0.0.1:44662","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-07-23T23:55:19.210834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.48242Z","time spent":"728.403624ms","remote":"127.0.0.1:44952","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/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:55:19.210823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.488583Z","time spent":"722.224784ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T23:55:19.210556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:18.452429Z","time spent":"758.087872ms","remote":"127.0.0.1:44368","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-07-23T23:55:20.67472Z","caller":"traceutil/trace.go:171","msg":"trace[654176291] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"377.854797ms","start":"2026-07-23T23:55:20.296841Z","end":"2026-07-23T23:55:20.674696Z","steps":["trace[654176291] 'process raft request' (duration: 377.656382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:20.674873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:20.296785Z","time spent":"378.009771ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:55:20.851002Z","caller":"traceutil/trace.go:171","msg":"trace[1861145751] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1291; }","duration":"398.285051ms","start":"2026-07-23T23:55:20.452689Z","end":"2026-07-23T23:55:20.850974Z","steps":["trace[1861145751] 'read index received' (duration: 221.809349ms)","trace[1861145751] 'applied index is now lower than readState.Index' (duration: 176.474522ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:20.85113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.416894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:20.851184Z","caller":"traceutil/trace.go:171","msg":"trace[57388573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"398.493606ms","start":"2026-07-23T23:55:20.452664Z","end":"2026-07-23T23:55:20.851157Z","steps":["trace[57388573] 'agreement among raft nodes before linearized reading' (duration: 398.414185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:20.85123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:20.452651Z","time spent":"398.567208ms","remote":"127.0.0.1:44368","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-07-23T23:55:20.851305Z","caller":"traceutil/trace.go:171","msg":"trace[300243363] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"417.571168ms","start":"2026-07-23T23:55:20.433705Z","end":"2026-07-23T23:55:20.851276Z","steps":["trace[300243363] 'process raft request' (duration: 417.114927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:20.851784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:20.433672Z","time spent":"417.692061ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:55:21.210916Z","caller":"traceutil/trace.go:171","msg":"trace[608858145] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"133.851961ms","start":"2026-07-23T23:55:21.077038Z","end":"2026-07-23T23:55:21.21089Z","steps":["trace[608858145] 'read index received' (duration: 133.707047ms)","trace[608858145] 'applied index is now lower than readState.Index' (duration: 143.634µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:55:21.21107Z","caller":"traceutil/trace.go:171","msg":"trace[258194703] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"189.496468ms","start":"2026-07-23T23:55:21.021534Z","end":"2026-07-23T23:55:21.21103Z","steps":["trace[258194703] 'process raft request' (duration: 189.16995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.21137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.300881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:55:21.211428Z","caller":"traceutil/trace.go:171","msg":"trace[361940896] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1241; }","duration":"134.424854ms","start":"2026-07-23T23:55:21.076988Z","end":"2026-07-23T23:55:21.211413Z","steps":["trace[361940896] 'agreement among raft nodes before linearized reading' (duration: 134.24814ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.792319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.424179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:55:21.792496Z","caller":"traceutil/trace.go:171","msg":"trace[641614129] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"457.73391ms","start":"2026-07-23T23:55:21.334745Z","end":"2026-07-23T23:55:21.792479Z","steps":["trace[641614129] 'process raft request' (duration: 457.674869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.792559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.334727Z","time spent":"457.802963ms","remote":"127.0.0.1:44466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:55:21.792752Z","caller":"traceutil/trace.go:171","msg":"trace[1757003995] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"521.148867ms","start":"2026-07-23T23:55:21.27159Z","end":"2026-07-23T23:55:21.792739Z","steps":["trace[1757003995] 'process raft request' (duration: 69.186705ms)","trace[1757003995] 'compare' (duration: 451.320506ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:21.792803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.27158Z","time spent":"521.195737ms","remote":"127.0.0.1:44662","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-07-23T23:55:21.792936Z","caller":"traceutil/trace.go:171","msg":"trace[716680230] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"513.302046ms","start":"2026-07-23T23:55:21.279622Z","end":"2026-07-23T23:55:21.792924Z","steps":["trace[716680230] 'read index received' (duration: 61.165491ms)","trace[716680230] 'applied index is now lower than readState.Index' (duration: 452.135675ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:21.793331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.714486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T23:55:21.793366Z","caller":"traceutil/trace.go:171","msg":"trace[2008963012] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1244; }","duration":"513.787548ms","start":"2026-07-23T23:55:21.27957Z","end":"2026-07-23T23:55:21.793357Z","steps":["trace[2008963012] 'agreement among raft nodes before linearized reading' (duration: 513.647285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.793556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.76256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:55:21.793559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.624734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:55:21.793614Z","caller":"traceutil/trace.go:171","msg":"trace[1223975468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"340.850102ms","start":"2026-07-23T23:55:21.452749Z","end":"2026-07-23T23:55:21.793599Z","steps":["trace[1223975468] 'agreement among raft nodes before linearized reading' (duration: 340.75713ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:21.793627Z","caller":"traceutil/trace.go:171","msg":"trace[2108788621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1244; }","duration":"513.734777ms","start":"2026-07-23T23:55:21.279875Z","end":"2026-07-23T23:55:21.79361Z","steps":["trace[2108788621] 'agreement among raft nodes before linearized reading' (duration: 513.520842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.793645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.452736Z","time spent":"340.903533ms","remote":"127.0.0.1:44368","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-07-23T23:55:21.793671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.279858Z","time spent":"513.804469ms","remote":"127.0.0.1:44662","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-07-23T23:55:21.793733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.047866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-23T23:55:21.793821Z","caller":"traceutil/trace.go:171","msg":"trace[560247320] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1244; }","duration":"512.171319ms","start":"2026-07-23T23:55:21.281628Z","end":"2026-07-23T23:55:21.7938Z","steps":["trace[560247320] 'agreement among raft nodes before linearized reading' (duration: 511.892182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:21.793867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.281618Z","time spent":"512.231501ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T23:55:21.794093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:21.279552Z","time spent":"514.520666ms","remote":"127.0.0.1:44662","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-07-23T23:55:21.994545Z","caller":"traceutil/trace.go:171","msg":"trace[944770680] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"196.63422ms","start":"2026-07-23T23:55:21.797879Z","end":"2026-07-23T23:55:21.994513Z","steps":["trace[944770680] 'process raft request' (duration: 196.431135ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:22.000282Z","caller":"traceutil/trace.go:171","msg":"trace[307218603] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"202.201995ms","start":"2026-07-23T23:55:21.798055Z","end":"2026-07-23T23:55:22.000257Z","steps":["trace[307218603] 'process raft request' (duration: 202.044761ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:22.000504Z","caller":"traceutil/trace.go:171","msg":"trace[355830082] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"202.162034ms","start":"2026-07-23T23:55:21.798327Z","end":"2026-07-23T23:55:22.000489Z","steps":["trace[355830082] 'process raft request' (duration: 202.089003ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:22.000613Z","caller":"traceutil/trace.go:171","msg":"trace[1010065270] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"202.37986ms","start":"2026-07-23T23:55:21.798147Z","end":"2026-07-23T23:55:22.000526Z","steps":["trace[1010065270] 'process raft request' (duration: 202.073552ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:24.10872Z","caller":"traceutil/trace.go:171","msg":"trace[790909228] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"102.584113ms","start":"2026-07-23T23:55:24.006113Z","end":"2026-07-23T23:55:24.108697Z","steps":["trace[790909228] 'process raft request' (duration: 101.775964ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:24.108978Z","caller":"traceutil/trace.go:171","msg":"trace[2014026319] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"101.998919ms","start":"2026-07-23T23:55:24.006956Z","end":"2026-07-23T23:55:24.108955Z","steps":["trace[2014026319] 'process raft request' (duration: 101.682581ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:24.109202Z","caller":"traceutil/trace.go:171","msg":"trace[1543500570] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"100.481393ms","start":"2026-07-23T23:55:24.00871Z","end":"2026-07-23T23:55:24.109192Z","steps":["trace[1543500570] 'process raft request' (duration: 100.174975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.261812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.517233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:32.261899Z","caller":"traceutil/trace.go:171","msg":"trace[1345992441] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1336; }","duration":"751.628516ms","start":"2026-07-23T23:55:31.510252Z","end":"2026-07-23T23:55:32.261881Z","steps":["trace[1345992441] 'count revisions from in-memory index tree' (duration: 751.435311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.261945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:31.510197Z","time spent":"751.737759ms","remote":"127.0.0.1:44702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:55:32.262029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.009809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:32.262116Z","caller":"traceutil/trace.go:171","msg":"trace[1105246195] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1336; }","duration":"722.101791ms","start":"2026-07-23T23:55:31.539982Z","end":"2026-07-23T23:55:32.262084Z","steps":["trace[1105246195] 'count revisions from in-memory index tree' (duration: 721.911027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.262168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:31.539909Z","time spent":"722.247774ms","remote":"127.0.0.1:32820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-23T23:55:32.262224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.848719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T23:55:32.262256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.398266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:55:32.262284Z","caller":"traceutil/trace.go:171","msg":"trace[1096546278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1336; }","duration":"432.938812ms","start":"2026-07-23T23:55:31.829327Z","end":"2026-07-23T23:55:32.262266Z","steps":["trace[1096546278] 'range keys from in-memory index tree' (duration: 432.718186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.26228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.684831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-23T23:55:32.262302Z","caller":"traceutil/trace.go:171","msg":"trace[901811062] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1336; }","duration":"491.495179ms","start":"2026-07-23T23:55:31.770792Z","end":"2026-07-23T23:55:32.262287Z","steps":["trace[901811062] 'count revisions from in-memory index tree' (duration: 491.293154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.262327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:31.829305Z","time spent":"433.013093ms","remote":"127.0.0.1:44662","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-07-23T23:55:32.262165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.521174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-23T23:55:32.262354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:31.770779Z","time spent":"491.56534ms","remote":"127.0.0.1:45060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:55:32.262353Z","caller":"traceutil/trace.go:171","msg":"trace[445691960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1336; }","duration":"120.800324ms","start":"2026-07-23T23:55:32.141537Z","end":"2026-07-23T23:55:32.262337Z","steps":["trace[445691960] 'range keys from in-memory index tree' (duration: 120.541058ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:32.262394Z","caller":"traceutil/trace.go:171","msg":"trace[1854991561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1336; }","duration":"226.7998ms","start":"2026-07-23T23:55:32.035581Z","end":"2026-07-23T23:55:32.262381Z","steps":["trace[1854991561] 'range keys from in-memory index tree' (duration: 226.313528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.262399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.659872ms","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-07-23T23:55:32.262506Z","caller":"traceutil/trace.go:171","msg":"trace[680538528] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1336; }","duration":"398.798505ms","start":"2026-07-23T23:55:31.86369Z","end":"2026-07-23T23:55:32.262489Z","steps":["trace[680538528] 'count revisions from in-memory index tree' (duration: 398.573539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.262549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:31.863669Z","time spent":"398.870816ms","remote":"127.0.0.1:44754","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":"warn","ts":"2026-07-23T23:55:32.262098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.338358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-23T23:55:32.262752Z","caller":"traceutil/trace.go:171","msg":"trace[681896322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1336; }","duration":"122.038375ms","start":"2026-07-23T23:55:32.140696Z","end":"2026-07-23T23:55:32.262734Z","steps":["trace[681896322] 'range keys from in-memory index tree' (duration: 121.193794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:32.85604Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370873183,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:55:33.356671Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085746231370873183,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:55:33.37503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.108832733s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T23:55:33.375442Z","caller":"traceutil/trace.go:171","msg":"trace[310628696] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"1.109314685s","start":"2026-07-23T23:55:32.266104Z","end":"2026-07-23T23:55:33.375418Z","steps":["trace[310628696] 'process raft request' (duration: 1.109159001s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.375577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.266082Z","time spent":"1.109414737s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:55:33.730208Z","caller":"traceutil/trace.go:171","msg":"trace[1202752310] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"1.463742565s","start":"2026-07-23T23:55:32.266439Z","end":"2026-07-23T23:55:33.730181Z","steps":["trace[1202752310] 'process raft request' (duration: 1.40900799s)","trace[1202752310] 'compare' (duration: 54.585462ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:33.730404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.266425Z","time spent":"1.463863498s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:55:33.730706Z","caller":"traceutil/trace.go:171","msg":"trace[60396253] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"1.46391528s","start":"2026-07-23T23:55:32.266778Z","end":"2026-07-23T23:55:33.730693Z","steps":["trace[60396253] 'process raft request' (duration: 1.463361056s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:33.73076Z","caller":"traceutil/trace.go:171","msg":"trace[1955046223] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"1.463793536s","start":"2026-07-23T23:55:32.266935Z","end":"2026-07-23T23:55:33.730729Z","steps":["trace[1955046223] 'process raft request' (duration: 1.463427508s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.730803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.266768Z","time spent":"1.463987391s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:55:33.730934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.266927Z","time spent":"1.463905029s","remote":"127.0.0.1:44662","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-07-23T23:55:33.758278Z","caller":"traceutil/trace.go:171","msg":"trace[489546523] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1391; }","duration":"1.403156748s","start":"2026-07-23T23:55:32.355101Z","end":"2026-07-23T23:55:33.758258Z","steps":["trace[489546523] 'read index received' (duration: 1.020225717s)","trace[489546523] 'applied index is now lower than readState.Index' (duration: 382.930011ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:55:33.758356Z","caller":"traceutil/trace.go:171","msg":"trace[1386636884] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"830.492205ms","start":"2026-07-23T23:55:32.92781Z","end":"2026-07-23T23:55:33.758302Z","steps":["trace[1386636884] 'process raft request' (duration: 830.234469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.758499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.314191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:55:33.758517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.927781Z","time spent":"830.655779ms","remote":"127.0.0.1:44662","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-07-23T23:55:33.758532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.403431505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-07-23T23:55:33.758564Z","caller":"traceutil/trace.go:171","msg":"trace[892588469] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1341; }","duration":"1.403504296s","start":"2026-07-23T23:55:32.35505Z","end":"2026-07-23T23:55:33.758554Z","steps":["trace[892588469] 'agreement among raft nodes before linearized reading' (duration: 1.403373973s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:33.758559Z","caller":"traceutil/trace.go:171","msg":"trace[1229936170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"305.411504ms","start":"2026-07-23T23:55:33.45313Z","end":"2026-07-23T23:55:33.758541Z","steps":["trace[1229936170] 'agreement among raft nodes before linearized reading' (duration: 305.300521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.758586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.285836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-23T23:55:33.758593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.355037Z","time spent":"1.403549778s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-23T23:55:33.758598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:33.453119Z","time spent":"305.471575ms","remote":"127.0.0.1:44356","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-07-23T23:55:33.758634Z","caller":"traceutil/trace.go:171","msg":"trace[107946995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1341; }","duration":"361.308546ms","start":"2026-07-23T23:55:33.397296Z","end":"2026-07-23T23:55:33.758604Z","steps":["trace[107946995] 'agreement among raft nodes before linearized reading' (duration: 361.242645ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.758655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:33.397246Z","time spent":"361.40472ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:55:33.758512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032515016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-23T23:55:33.758693Z","caller":"traceutil/trace.go:171","msg":"trace[1095886216] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1341; }","duration":"1.032739991s","start":"2026-07-23T23:55:32.725946Z","end":"2026-07-23T23:55:33.758686Z","steps":["trace[1095886216] 'agreement among raft nodes before linearized reading' (duration: 1.032472885s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.758714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.50912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:55:33.758714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:32.725925Z","time spent":"1.032782582s","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-23T23:55:33.758732Z","caller":"traceutil/trace.go:171","msg":"trace[562480408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"527.565141ms","start":"2026-07-23T23:55:33.231159Z","end":"2026-07-23T23:55:33.758725Z","steps":["trace[562480408] 'agreement among raft nodes before linearized reading' (duration: 527.540341ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:33.758753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:33.231137Z","time spent":"527.613323ms","remote":"127.0.0.1:44368","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-07-23T23:55:33.758972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.25877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-23T23:55:33.759018Z","caller":"traceutil/trace.go:171","msg":"trace[1188702540] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1341; }","duration":"141.769102ms","start":"2026-07-23T23:55:33.617234Z","end":"2026-07-23T23:55:33.759003Z","steps":["trace[1188702540] 'agreement among raft nodes before linearized reading' (duration: 141.218199ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:51.664902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.635527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:55:51.66499Z","caller":"traceutil/trace.go:171","msg":"trace[1669373474] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1423; }","duration":"137.808381ms","start":"2026-07-23T23:55:51.527163Z","end":"2026-07-23T23:55:51.664972Z","steps":["trace[1669373474] 'count revisions from in-memory index tree' (duration: 137.492343ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:52.024608Z","caller":"traceutil/trace.go:171","msg":"trace[941287915] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1482; }","duration":"206.478376ms","start":"2026-07-23T23:55:51.818097Z","end":"2026-07-23T23:55:52.024576Z","steps":["trace[941287915] 'read index received' (duration: 206.339863ms)","trace[941287915] 'applied index is now lower than readState.Index' (duration: 137.163µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:55:52.024648Z","caller":"traceutil/trace.go:171","msg":"trace[789390260] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"206.983288ms","start":"2026-07-23T23:55:51.817628Z","end":"2026-07-23T23:55:52.024612Z","steps":["trace[789390260] 'process raft request' (duration: 206.760613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:52.02485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.731692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T23:55:52.024893Z","caller":"traceutil/trace.go:171","msg":"trace[1414232590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1424; }","duration":"206.835475ms","start":"2026-07-23T23:55:51.818046Z","end":"2026-07-23T23:55:52.024882Z","steps":["trace[1414232590] 'agreement among raft nodes before linearized reading' (duration: 206.666441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:52.196453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.608242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:55:52.196635Z","caller":"traceutil/trace.go:171","msg":"trace[1918958522] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"171.938614ms","start":"2026-07-23T23:55:52.024679Z","end":"2026-07-23T23:55:52.196618Z","steps":["trace[1918958522] 'read index received' (duration: 57.076526ms)","trace[1918958522] 'applied index is now lower than readState.Index' (duration: 114.860808ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:55:52.196611Z","caller":"traceutil/trace.go:171","msg":"trace[1756887696] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"365.048808ms","start":"2026-07-23T23:55:51.831526Z","end":"2026-07-23T23:55:52.196574Z","steps":["trace[1756887696] 'process raft request' (duration: 250.217421ms)","trace[1756887696] 'compare' (duration: 114.462737ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:52.196782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:51.831499Z","time spent":"365.195832ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:55:52.196853Z","caller":"traceutil/trace.go:171","msg":"trace[654879637] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"167.811054ms","start":"2026-07-23T23:55:52.029015Z","end":"2026-07-23T23:55:52.196826Z","steps":["trace[654879637] 'process raft request' (duration: 167.553138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:52.196989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.546362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T23:55:52.197043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.212263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:55:52.197065Z","caller":"traceutil/trace.go:171","msg":"trace[1845279381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1426; }","duration":"351.656875ms","start":"2026-07-23T23:55:51.845391Z","end":"2026-07-23T23:55:52.197048Z","steps":["trace[1845279381] 'agreement among raft nodes before linearized reading' (duration: 351.282556ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:52.197104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.316386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-07-23T23:55:52.197112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:51.84538Z","time spent":"351.722846ms","remote":"127.0.0.1:44662","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-07-23T23:55:52.197143Z","caller":"traceutil/trace.go:171","msg":"trace[1794248989] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1426; }","duration":"324.386287ms","start":"2026-07-23T23:55:51.872746Z","end":"2026-07-23T23:55:52.197133Z","steps":["trace[1794248989] 'agreement among raft nodes before linearized reading' (duration: 323.952247ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:52.197151Z","caller":"traceutil/trace.go:171","msg":"trace[1115878437] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1426; }","duration":"324.308996ms","start":"2026-07-23T23:55:51.872764Z","end":"2026-07-23T23:55:52.197073Z","steps":["trace[1115878437] 'agreement among raft nodes before linearized reading' (duration: 323.925237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:55:52.197183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:51.872735Z","time spent":"324.435498ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-23T23:55:52.197194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:55:51.872751Z","time spent":"324.431018ms","remote":"127.0.0.1:44662","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-07-23T23:55:52.420868Z","caller":"traceutil/trace.go:171","msg":"trace[1427871586] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"218.318031ms","start":"2026-07-23T23:55:52.202531Z","end":"2026-07-23T23:55:52.420849Z","steps":["trace[1427871586] 'process raft request' (duration: 218.179288ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:52.421044Z","caller":"traceutil/trace.go:171","msg":"trace[28094364] linearizableReadLoop","detail":"{readStateIndex:1488; appliedIndex:1485; }","duration":"215.504283ms","start":"2026-07-23T23:55:52.205529Z","end":"2026-07-23T23:55:52.421033Z","steps":["trace[28094364] 'read index received' (duration: 47.328381ms)","trace[28094364] 'applied index is now lower than readState.Index' (duration: 168.174962ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:55:52.421142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.594505ms","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-07-23T23:55:52.421182Z","caller":"traceutil/trace.go:171","msg":"trace[345788298] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1429; }","duration":"215.674418ms","start":"2026-07-23T23:55:52.205498Z","end":"2026-07-23T23:55:52.421172Z","steps":["trace[345788298] 'agreement among raft nodes before linearized reading' (duration: 215.575745ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:55:52.421181Z","caller":"traceutil/trace.go:171","msg":"trace[2105373274] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"218.300481ms","start":"2026-07-23T23:55:52.202833Z","end":"2026-07-23T23:55:52.421134Z","steps":["trace[2105373274] 'process raft request' (duration: 217.980593ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:56:33.999951Z","caller":"traceutil/trace.go:171","msg":"trace[314665560] transaction","detail":"{read_only:false; response_revision:1616; number_of_response:1; }","duration":"100.739188ms","start":"2026-07-23T23:56:33.899183Z","end":"2026-07-23T23:56:33.999922Z","steps":["trace[314665560] 'process raft request' (duration: 85.036409ms)","trace[314665560] 'compare' (duration: 15.598047ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:58:45.042773Z","caller":"traceutil/trace.go:171","msg":"trace[1331695160] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"186.603445ms","start":"2026-07-23T23:58:44.856146Z","end":"2026-07-23T23:58:45.042749Z","steps":["trace[1331695160] 'process raft request' (duration: 186.416821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:59:50.186786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.85195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:59:50.186958Z","caller":"traceutil/trace.go:171","msg":"trace[1976169301] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2543; }","duration":"385.075366ms","start":"2026-07-23T23:59:49.801861Z","end":"2026-07-23T23:59:50.186937Z","steps":["trace[1976169301] 'count revisions from in-memory index tree' (duration: 384.732217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:59:50.187665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:59:49.801845Z","time spent":"385.799624ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}