{"level":"warn","ts":"2026-07-23T23:50:32.65835Z","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:50:32.658446Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-23T23:50:32.658506Z","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:50:32.658517Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-23T23:50:32.658535Z","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:50:32.659178Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-07-23T23:50:32.659247Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-23T23:50:32.66313Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.691547ms"} {"level":"info","ts":"2026-07-23T23:50:32.668426Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-07-23T23:50:32.66856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T23:50:32.668595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-07-23T23:50:32.668618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T23:50:32.668628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-07-23T23:50:32.668675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-07-23T23:50:32.671514Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T23:50:32.672677Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T23:50:32.674236Z","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:50:32.676781Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T23:50:32.677816Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T23:50:32.678056Z","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:50:32.678107Z","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:50:32.678119Z","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:50:32.679615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-07-23T23:50:32.680145Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-23T23:50:32.682457Z","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:50:32.68264Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-23T23:50:32.682703Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-23T23:50:32.682699Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T23:50:32.682743Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T23:50:32.969261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T23:50:32.969329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T23:50:32.969372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-07-23T23:50:32.969401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-07-23T23:50:32.969486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-23T23:50:32.969508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-07-23T23:50:32.969528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-23T23:50:32.97177Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T23:50:32.97189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:50:32.972073Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:50:32.97217Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:50:32.972674Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T23:50:32.972747Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T23:50:32.973441Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:50:32.973661Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:50:32.973752Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:50:32.974929Z","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:50:32.976207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"warn","ts":"2026-07-23T23:50:33.285788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.151716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:33.285866Z","caller":"traceutil/trace.go:171","msg":"trace[2036677116] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"103.29708ms","start":"2026-07-23T23:50:33.182556Z","end":"2026-07-23T23:50:33.285853Z","steps":["trace[2036677116] 'count revisions from in-memory index tree' (duration: 103.061774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:33.285911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.107319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:50:33.285897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.918934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:33.285939Z","caller":"traceutil/trace.go:171","msg":"trace[2007418255] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"143.13044ms","start":"2026-07-23T23:50:33.142796Z","end":"2026-07-23T23:50:33.285927Z","steps":["trace[2007418255] 'count revisions from in-memory index tree' (duration: 142.893114ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:33.285982Z","caller":"traceutil/trace.go:171","msg":"trace[2036073015] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"143.040318ms","start":"2026-07-23T23:50:33.142917Z","end":"2026-07-23T23:50:33.285958Z","steps":["trace[2036073015] 'range keys from in-memory index tree' (duration: 142.869312ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:34.712031Z","caller":"traceutil/trace.go:171","msg":"trace[312745790] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"347.767619ms","start":"2026-07-23T23:50:34.364229Z","end":"2026-07-23T23:50:34.711996Z","steps":["trace[312745790] 'read index received' (duration: 347.027909ms)","trace[312745790] 'applied index is now lower than readState.Index' (duration: 738.5µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:34.712426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.168289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:34.712518Z","caller":"traceutil/trace.go:171","msg":"trace[824067766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2; }","duration":"348.298022ms","start":"2026-07-23T23:50:34.364201Z","end":"2026-07-23T23:50:34.712499Z","steps":["trace[824067766] 'agreement among raft nodes before linearized reading' (duration: 347.940163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:34.712563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.364193Z","time spent":"348.361434ms","remote":"127.0.0.1:58862","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:50:34.712692Z","caller":"traceutil/trace.go:171","msg":"trace[1929870776] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"349.978887ms","start":"2026-07-23T23:50:34.362115Z","end":"2026-07-23T23:50:34.712094Z","steps":["trace[1929870776] 'process raft request' (duration: 349.00923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:34.713089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.362095Z","time spent":"350.630324ms","remote":"127.0.0.1:58920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:50:35.010336Z","caller":"traceutil/trace.go:171","msg":"trace[332533084] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"637.576041ms","start":"2026-07-23T23:50:34.37273Z","end":"2026-07-23T23:50:35.010306Z","steps":["trace[332533084] 'process raft request' (duration: 637.361525ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.010537Z","caller":"traceutil/trace.go:171","msg":"trace[232000593] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"298.405078ms","start":"2026-07-23T23:50:34.712114Z","end":"2026-07-23T23:50:35.010519Z","steps":["trace[232000593] 'read index received' (duration: 297.892104ms)","trace[232000593] 'applied index is now lower than readState.Index' (duration: 511.664µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:50:35.01068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.877949ms","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:50:35.010697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.372714Z","time spent":"637.701404ms","remote":"127.0.0.1:59116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:50:35.010866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.810669ms","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:50:35.010907Z","caller":"traceutil/trace.go:171","msg":"trace[484302146] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"511.86452ms","start":"2026-07-23T23:50:34.499032Z","end":"2026-07-23T23:50:35.010897Z","steps":["trace[484302146] 'agreement among raft nodes before linearized reading' (duration: 511.797848ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.010879Z","caller":"traceutil/trace.go:171","msg":"trace[1799063315] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"557.403799ms","start":"2026-07-23T23:50:34.453445Z","end":"2026-07-23T23:50:35.010849Z","steps":["trace[1799063315] 'process raft request' (duration: 556.897227ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.010969Z","caller":"traceutil/trace.go:171","msg":"trace[1531940634] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"557.361019ms","start":"2026-07-23T23:50:34.4536Z","end":"2026-07-23T23:50:35.010961Z","steps":["trace[1531940634] 'process raft request' (duration: 556.778974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.453588Z","time spent":"557.40653ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:50:35.0111Z","caller":"traceutil/trace.go:171","msg":"trace[152182506] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"557.487982ms","start":"2026-07-23T23:50:34.453603Z","end":"2026-07-23T23:50:35.011091Z","steps":["trace[152182506] 'process raft request' (duration: 556.797144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.453023Z","time spent":"557.962474ms","remote":"127.0.0.1:59274","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:50:35.011141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.453588Z","time spent":"557.536323ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:50:35.010718Z","caller":"traceutil/trace.go:171","msg":"trace[967814798] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"637.969801ms","start":"2026-07-23T23:50:34.372738Z","end":"2026-07-23T23:50:35.010707Z","steps":["trace[967814798] 'agreement among raft nodes before linearized reading' (duration: 637.849438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.372727Z","time spent":"638.465224ms","remote":"127.0.0.1:59070","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":"info","ts":"2026-07-23T23:50:35.010753Z","caller":"traceutil/trace.go:171","msg":"trace[1117163640] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"558.228731ms","start":"2026-07-23T23:50:34.452516Z","end":"2026-07-23T23:50:35.010745Z","steps":["trace[1117163640] 'process raft request' (duration: 557.733918ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.011336Z","caller":"traceutil/trace.go:171","msg":"trace[2136978313] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"552.002436ms","start":"2026-07-23T23:50:34.459324Z","end":"2026-07-23T23:50:35.011327Z","steps":["trace[2136978313] 'process raft request' (duration: 551.152084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.459318Z","time spent":"552.040947ms","remote":"127.0.0.1:59046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:50:35.011385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.4525Z","time spent":"558.853617ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:50:35.011407Z","caller":"traceutil/trace.go:171","msg":"trace[1914212238] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"558.384244ms","start":"2026-07-23T23:50:34.453008Z","end":"2026-07-23T23:50:35.011393Z","steps":["trace[1914212238] 'process raft request' (duration: 557.297046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.541165ms","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:50:35.011504Z","caller":"traceutil/trace.go:171","msg":"trace[75668140] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"589.71595ms","start":"2026-07-23T23:50:34.421756Z","end":"2026-07-23T23:50:35.011472Z","steps":["trace[75668140] 'agreement among raft nodes before linearized reading' (duration: 589.441563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.011521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.452999Z","time spent":"558.470207ms","remote":"127.0.0.1:59344","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:50:35.01157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.421736Z","time spent":"589.823472ms","remote":"127.0.0.1:58976","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:50:35.01163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.010415ms","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:50:35.010936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.499025Z","time spent":"511.905151ms","remote":"127.0.0.1:58976","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:50:35.011707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.065018ms","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:50:35.012388Z","caller":"traceutil/trace.go:171","msg":"trace[1311889053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"637.689933ms","start":"2026-07-23T23:50:34.374624Z","end":"2026-07-23T23:50:35.012314Z","steps":["trace[1311889053] 'agreement among raft nodes before linearized reading' (duration: 637.065217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.012542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.374621Z","time spent":"637.884419ms","remote":"127.0.0.1:59122","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":"info","ts":"2026-07-23T23:50:35.011673Z","caller":"traceutil/trace.go:171","msg":"trace[1842133767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"637.070898ms","start":"2026-07-23T23:50:34.374592Z","end":"2026-07-23T23:50:35.011663Z","steps":["trace[1842133767] 'agreement among raft nodes before linearized reading' (duration: 637.002305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.012635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.374584Z","time spent":"638.035982ms","remote":"127.0.0.1:59122","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":"warn","ts":"2026-07-23T23:50:35.011913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.060239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-07-23T23:50:35.012812Z","caller":"traceutil/trace.go:171","msg":"trace[727235443] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"639.962474ms","start":"2026-07-23T23:50:34.372826Z","end":"2026-07-23T23:50:35.012789Z","steps":["trace[727235443] 'agreement among raft nodes before linearized reading' (duration: 638.991739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.01288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.372823Z","time spent":"640.020695ms","remote":"127.0.0.1:59046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3192,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-23T23:50:35.011939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.880912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.013027Z","caller":"traceutil/trace.go:171","msg":"trace[22904200] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:0; response_revision:10; }","duration":"567.007501ms","start":"2026-07-23T23:50:34.446006Z","end":"2026-07-23T23:50:35.013013Z","steps":["trace[22904200] 'agreement among raft nodes before linearized reading' (duration: 565.904233ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.013071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.445986Z","time spent":"567.074733ms","remote":"127.0.0.1:58886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-07-23T23:50:35.011972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.173312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.013218Z","caller":"traceutil/trace.go:171","msg":"trace[1585423861] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"640.424726ms","start":"2026-07-23T23:50:34.372783Z","end":"2026-07-23T23:50:35.013208Z","steps":["trace[1585423861] 'agreement among raft nodes before linearized reading' (duration: 639.170883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.013269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.372777Z","time spent":"640.483327ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-23T23:50:35.012018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.833459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.013421Z","caller":"traceutil/trace.go:171","msg":"trace[893503389] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"562.253357ms","start":"2026-07-23T23:50:34.451156Z","end":"2026-07-23T23:50:35.013409Z","steps":["trace[893503389] 'agreement among raft nodes before linearized reading' (duration: 560.84556ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.013458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.451138Z","time spent":"562.310498ms","remote":"127.0.0.1:58950","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:50:35.013876Z","caller":"traceutil/trace.go:171","msg":"trace[1204405012] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"561.118507ms","start":"2026-07-23T23:50:34.452741Z","end":"2026-07-23T23:50:35.010769Z","steps":["trace[1204405012] 'process raft request' (duration: 557.542213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.013965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.452689Z","time spent":"561.23024ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:50:35.014586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.147446ms","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:50:35.015275Z","caller":"traceutil/trace.go:171","msg":"trace[2078416728] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"567.892565ms","start":"2026-07-23T23:50:34.447364Z","end":"2026-07-23T23:50:35.015257Z","steps":["trace[2078416728] 'agreement among raft nodes before linearized reading' (duration: 564.336552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.015342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:50:34.447319Z","time spent":"568.008579ms","remote":"127.0.0.1:58976","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:50:35.295964Z","caller":"traceutil/trace.go:171","msg":"trace[733181185] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"278.746332ms","start":"2026-07-23T23:50:35.017187Z","end":"2026-07-23T23:50:35.295934Z","steps":["trace[733181185] 'process raft request' (duration: 261.914859ms)","trace[733181185] 'compare' (duration: 16.574655ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:35.29613Z","caller":"traceutil/trace.go:171","msg":"trace[890652667] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"277.380044ms","start":"2026-07-23T23:50:35.018724Z","end":"2026-07-23T23:50:35.296104Z","steps":["trace[890652667] 'read index received' (duration: 23.152199ms)","trace[890652667] 'applied index is now lower than readState.Index' (duration: 254.226865ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:35.296374Z","caller":"traceutil/trace.go:171","msg":"trace[526408231] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"275.897676ms","start":"2026-07-23T23:50:35.020397Z","end":"2026-07-23T23:50:35.296294Z","steps":["trace[526408231] 'process raft request' (duration: 275.579918ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.296437Z","caller":"traceutil/trace.go:171","msg":"trace[1548568123] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"275.807113ms","start":"2026-07-23T23:50:35.020618Z","end":"2026-07-23T23:50:35.296425Z","steps":["trace[1548568123] 'process raft request' (duration: 275.395383ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.296615Z","caller":"traceutil/trace.go:171","msg":"trace[1892036607] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"277.656372ms","start":"2026-07-23T23:50:35.01893Z","end":"2026-07-23T23:50:35.296586Z","steps":["trace[1892036607] 'process raft request' (duration: 276.886141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.296741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.880528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-22fzw\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-07-23T23:50:35.296804Z","caller":"traceutil/trace.go:171","msg":"trace[982698922] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-22fzw; range_end:; response_count:1; response_revision:19; }","duration":"277.9712ms","start":"2026-07-23T23:50:35.018819Z","end":"2026-07-23T23:50:35.29679Z","steps":["trace[982698922] 'agreement among raft nodes before linearized reading' (duration: 277.802266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.296818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.640632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.296861Z","caller":"traceutil/trace.go:171","msg":"trace[483567481] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:19; }","duration":"225.711673ms","start":"2026-07-23T23:50:35.07114Z","end":"2026-07-23T23:50:35.296851Z","steps":["trace[483567481] 'agreement among raft nodes before linearized reading' (duration: 225.638962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.296883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.084888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-23T23:50:35.296952Z","caller":"traceutil/trace.go:171","msg":"trace[851364843] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"222.170421ms","start":"2026-07-23T23:50:35.074768Z","end":"2026-07-23T23:50:35.296939Z","steps":["trace[851364843] 'agreement among raft nodes before linearized reading' (duration: 222.032547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.296959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.216354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-23T23:50:35.296987Z","caller":"traceutil/trace.go:171","msg":"trace[293443585] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"227.245755ms","start":"2026-07-23T23:50:35.069734Z","end":"2026-07-23T23:50:35.29698Z","steps":["trace[293443585] 'agreement among raft nodes before linearized reading' (duration: 227.196573ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.297026Z","caller":"traceutil/trace.go:171","msg":"trace[1714205341] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"273.735899ms","start":"2026-07-23T23:50:35.023278Z","end":"2026-07-23T23:50:35.297014Z","steps":["trace[1714205341] 'process raft request' (duration: 272.772234ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.29694Z","caller":"traceutil/trace.go:171","msg":"trace[1691294466] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"277.482747ms","start":"2026-07-23T23:50:35.019389Z","end":"2026-07-23T23:50:35.296872Z","steps":["trace[1691294466] 'process raft request' (duration: 276.505762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.297063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.107101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-07-23T23:50:35.297143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.417322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-07-23T23:50:35.29718Z","caller":"traceutil/trace.go:171","msg":"trace[525052098] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"278.473152ms","start":"2026-07-23T23:50:35.018697Z","end":"2026-07-23T23:50:35.29717Z","steps":["trace[525052098] 'agreement among raft nodes before linearized reading' (duration: 278.414051ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.297182Z","caller":"traceutil/trace.go:171","msg":"trace[1031874031] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"277.928569ms","start":"2026-07-23T23:50:35.019241Z","end":"2026-07-23T23:50:35.297169Z","steps":["trace[1031874031] 'process raft request' (duration: 276.617275ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.297256Z","caller":"traceutil/trace.go:171","msg":"trace[1964827496] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"227.245913ms","start":"2026-07-23T23:50:35.069918Z","end":"2026-07-23T23:50:35.297164Z","steps":["trace[1964827496] 'agreement among raft nodes before linearized reading' (duration: 227.11661ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.297294Z","caller":"traceutil/trace.go:171","msg":"trace[1929217364] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"277.137038ms","start":"2026-07-23T23:50:35.020146Z","end":"2026-07-23T23:50:35.297283Z","steps":["trace[1929217364] 'process raft request' (duration: 275.804713ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.29731Z","caller":"traceutil/trace.go:171","msg":"trace[1024884828] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"277.352545ms","start":"2026-07-23T23:50:35.019923Z","end":"2026-07-23T23:50:35.297276Z","steps":["trace[1024884828] 'process raft request' (duration: 275.991669ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.521354Z","caller":"traceutil/trace.go:171","msg":"trace[416728053] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"220.347634ms","start":"2026-07-23T23:50:35.300983Z","end":"2026-07-23T23:50:35.521331Z","steps":["trace[416728053] 'process raft request' (duration: 217.752455ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.52161Z","caller":"traceutil/trace.go:171","msg":"trace[1931692453] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"219.827259ms","start":"2026-07-23T23:50:35.301715Z","end":"2026-07-23T23:50:35.521542Z","steps":["trace[1931692453] 'process raft request' (duration: 219.651075ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.521684Z","caller":"traceutil/trace.go:171","msg":"trace[1743987972] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"219.832389ms","start":"2026-07-23T23:50:35.301833Z","end":"2026-07-23T23:50:35.521666Z","steps":["trace[1743987972] 'process raft request' (duration: 219.615654ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.521776Z","caller":"traceutil/trace.go:171","msg":"trace[447261516] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"219.814009ms","start":"2026-07-23T23:50:35.301911Z","end":"2026-07-23T23:50:35.521725Z","steps":["trace[447261516] 'process raft request' (duration: 219.613654ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.521824Z","caller":"traceutil/trace.go:171","msg":"trace[65335441] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"218.650048ms","start":"2026-07-23T23:50:35.303163Z","end":"2026-07-23T23:50:35.521813Z","steps":["trace[65335441] 'process raft request' (duration: 218.458043ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.52199Z","caller":"traceutil/trace.go:171","msg":"trace[537174226] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"218.73086ms","start":"2026-07-23T23:50:35.303227Z","end":"2026-07-23T23:50:35.521958Z","steps":["trace[537174226] 'process raft request' (duration: 218.520715ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522053Z","caller":"traceutil/trace.go:171","msg":"trace[837227019] linearizableReadLoop","detail":"{readStateIndex:33; appliedIndex:23; }","duration":"218.093404ms","start":"2026-07-23T23:50:35.303937Z","end":"2026-07-23T23:50:35.52203Z","steps":["trace[837227019] 'read index received' (duration: 214.849588ms)","trace[837227019] 'applied index is now lower than readState.Index' (duration: 3.242686ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:35.522077Z","caller":"traceutil/trace.go:171","msg":"trace[734185665] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"218.838334ms","start":"2026-07-23T23:50:35.303222Z","end":"2026-07-23T23:50:35.52206Z","steps":["trace[734185665] 'process raft request' (duration: 218.465564ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522192Z","caller":"traceutil/trace.go:171","msg":"trace[826609916] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"218.038533ms","start":"2026-07-23T23:50:35.304146Z","end":"2026-07-23T23:50:35.522185Z","steps":["trace[826609916] 'process raft request' (duration: 217.830397ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522265Z","caller":"traceutil/trace.go:171","msg":"trace[1170076547] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"218.966497ms","start":"2026-07-23T23:50:35.303293Z","end":"2026-07-23T23:50:35.522259Z","steps":["trace[1170076547] 'process raft request' (duration: 218.498194ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522298Z","caller":"traceutil/trace.go:171","msg":"trace[670067504] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"218.992158ms","start":"2026-07-23T23:50:35.303292Z","end":"2026-07-23T23:50:35.522285Z","steps":["trace[670067504] 'process raft request' (duration: 218.554076ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522321Z","caller":"traceutil/trace.go:171","msg":"trace[707397066] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"218.955896ms","start":"2026-07-23T23:50:35.303358Z","end":"2026-07-23T23:50:35.522314Z","steps":["trace[707397066] 'process raft request' (duration: 218.564746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.522341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.258618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.522425Z","caller":"traceutil/trace.go:171","msg":"trace[1932326253] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:30; }","duration":"218.385731ms","start":"2026-07-23T23:50:35.304015Z","end":"2026-07-23T23:50:35.522401Z","steps":["trace[1932326253] 'agreement among raft nodes before linearized reading' (duration: 218.195027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.522467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.044266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-23T23:50:35.522475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.956962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.522494Z","caller":"traceutil/trace.go:171","msg":"trace[1277304122] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:30; }","duration":"176.094207ms","start":"2026-07-23T23:50:35.346392Z","end":"2026-07-23T23:50:35.522486Z","steps":["trace[1277304122] 'agreement among raft nodes before linearized reading' (duration: 176.049515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.522479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.530115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.522518Z","caller":"traceutil/trace.go:171","msg":"trace[516977463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:30; }","duration":"103.007953ms","start":"2026-07-23T23:50:35.419497Z","end":"2026-07-23T23:50:35.522505Z","steps":["trace[516977463] 'agreement among raft nodes before linearized reading' (duration: 102.927631ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:35.522537Z","caller":"traceutil/trace.go:171","msg":"trace[466755553] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:30; }","duration":"218.609037ms","start":"2026-07-23T23:50:35.303908Z","end":"2026-07-23T23:50:35.522517Z","steps":["trace[466755553] 'agreement among raft nodes before linearized reading' (duration: 218.525445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:35.522649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.372404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:50:35.522751Z","caller":"traceutil/trace.go:171","msg":"trace[853189023] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:30; }","duration":"176.58371ms","start":"2026-07-23T23:50:35.346112Z","end":"2026-07-23T23:50:35.522696Z","steps":["trace[853189023] 'agreement among raft nodes before linearized reading' (duration: 176.392895ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:38.5573Z","caller":"traceutil/trace.go:171","msg":"trace[682486572] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"150.829242ms","start":"2026-07-23T23:50:38.406448Z","end":"2026-07-23T23:50:38.557277Z","steps":["trace[682486572] 'process raft request' (duration: 150.709739ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:08.51095Z","caller":"traceutil/trace.go:171","msg":"trace[1529721532] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"169.588359ms","start":"2026-07-23T23:51:08.341345Z","end":"2026-07-23T23:51:08.510933Z","steps":["trace[1529721532] 'process raft request' (duration: 169.411735ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:09.327388Z","caller":"traceutil/trace.go:171","msg":"trace[1467377344] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"168.659166ms","start":"2026-07-23T23:51:09.158708Z","end":"2026-07-23T23:51:09.327367Z","steps":["trace[1467377344] 'process raft request' (duration: 168.620175ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:09.32773Z","caller":"traceutil/trace.go:171","msg":"trace[1913898298] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"192.792651ms","start":"2026-07-23T23:51:09.13493Z","end":"2026-07-23T23:51:09.327722Z","steps":["trace[1913898298] 'process raft request' (duration: 192.273337ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:09.666851Z","caller":"traceutil/trace.go:171","msg":"trace[1892060974] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"347.788146ms","start":"2026-07-23T23:51:09.319044Z","end":"2026-07-23T23:51:09.666833Z","steps":["trace[1892060974] 'read index received' (duration: 9.288015ms)","trace[1892060974] 'applied index is now lower than readState.Index' (duration: 338.499541ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:51:09.666971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.905889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:09.666994Z","caller":"traceutil/trace.go:171","msg":"trace[673470739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"347.979771ms","start":"2026-07-23T23:51:09.319007Z","end":"2026-07-23T23:51:09.666986Z","steps":["trace[673470739] 'agreement among raft nodes before linearized reading' (duration: 347.898729ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:09.666964Z","caller":"traceutil/trace.go:171","msg":"trace[611804640] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"370.108033ms","start":"2026-07-23T23:51:09.296816Z","end":"2026-07-23T23:51:09.666924Z","steps":["trace[611804640] 'process raft request' (duration: 369.870857ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:09.66702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:09.318988Z","time spent":"348.026663ms","remote":"127.0.0.1:58862","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:51:09.667129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:09.296798Z","time spent":"370.239436ms","remote":"127.0.0.1:58916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:51:09.813495Z","caller":"traceutil/trace.go:171","msg":"trace[867581498] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"145.415874ms","start":"2026-07-23T23:51:09.668063Z","end":"2026-07-23T23:51:09.813478Z","steps":["trace[867581498] 'read index received' (duration: 144.829599ms)","trace[867581498] 'applied index is now lower than readState.Index' (duration: 585.185µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:51:09.813586Z","caller":"traceutil/trace.go:171","msg":"trace[496010652] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"365.43047ms","start":"2026-07-23T23:51:09.44815Z","end":"2026-07-23T23:51:09.813581Z","steps":["trace[496010652] 'process raft request' (duration: 365.101341ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:09.813653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:09.448129Z","time spent":"365.474041ms","remote":"127.0.0.1:58916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:51:09.813769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.700631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:09.813785Z","caller":"traceutil/trace.go:171","msg":"trace[479218558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"145.753253ms","start":"2026-07-23T23:51:09.668026Z","end":"2026-07-23T23:51:09.813779Z","steps":["trace[479218558] 'agreement among raft nodes before linearized reading' (duration: 145.704612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:09.813935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.274258ms","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:51:09.813947Z","caller":"traceutil/trace.go:171","msg":"trace[1624382543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"132.31473ms","start":"2026-07-23T23:51:09.681628Z","end":"2026-07-23T23:51:09.813943Z","steps":["trace[1624382543] 'agreement among raft nodes before linearized reading' (duration: 132.284809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:09.814086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.238713ms","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:51:09.814125Z","caller":"traceutil/trace.go:171","msg":"trace[23760863] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"450.464567ms","start":"2026-07-23T23:51:09.363653Z","end":"2026-07-23T23:51:09.814118Z","steps":["trace[23760863] 'process raft request' (duration: 449.230034ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:51:09.814147Z","caller":"traceutil/trace.go:171","msg":"trace[880456162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"128.327276ms","start":"2026-07-23T23:51:09.685804Z","end":"2026-07-23T23:51:09.814131Z","steps":["trace[880456162] 'agreement among raft nodes before linearized reading' (duration: 128.218942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:09.814162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:09.363626Z","time spent":"450.513988ms","remote":"127.0.0.1:58916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:14.66127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.588172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T23:51:14.66141Z","caller":"traceutil/trace.go:171","msg":"trace[2042307627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"117.789337ms","start":"2026-07-23T23:51:14.543591Z","end":"2026-07-23T23:51:14.661381Z","steps":["trace[2042307627] 'range keys from in-memory index tree' (duration: 117.032237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:15.61499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680221382152806683,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-23T23:51:15.772759Z","caller":"traceutil/trace.go:171","msg":"trace[1079154182] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"657.815109ms","start":"2026-07-23T23:51:15.114919Z","end":"2026-07-23T23:51:15.772734Z","steps":["trace[1079154182] 'read index received' (duration: 656.802792ms)","trace[1079154182] 'applied index is now lower than readState.Index' (duration: 1.011427ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:51:15.772872Z","caller":"traceutil/trace.go:171","msg":"trace[1298033064] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"681.84343ms","start":"2026-07-23T23:51:15.091019Z","end":"2026-07-23T23:51:15.772863Z","steps":["trace[1298033064] 'process raft request' (duration: 680.999539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:15.772982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:15.090995Z","time spent":"681.905742ms","remote":"127.0.0.1:58962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:51:15.773421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.501887ms","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:51:15.773459Z","caller":"traceutil/trace.go:171","msg":"trace[1404218246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"658.579539ms","start":"2026-07-23T23:51:15.114869Z","end":"2026-07-23T23:51:15.773448Z","steps":["trace[1404218246] 'agreement among raft nodes before linearized reading' (duration: 658.380074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:15.773491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:15.114849Z","time spent":"658.63533ms","remote":"127.0.0.1:59122","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:51:15.773723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.334523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:51:15.773843Z","caller":"traceutil/trace.go:171","msg":"trace[1348825727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"477.506577ms","start":"2026-07-23T23:51:15.296308Z","end":"2026-07-23T23:51:15.773814Z","steps":["trace[1348825727] 'agreement among raft nodes before linearized reading' (duration: 477.296882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:15.773844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.61688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sxbf8\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-07-23T23:51:15.773904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:15.296293Z","time spent":"477.601439ms","remote":"127.0.0.1:58878","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:51:15.773911Z","caller":"traceutil/trace.go:171","msg":"trace[250395634] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sxbf8; range_end:; response_count:1; response_revision:591; }","duration":"455.710993ms","start":"2026-07-23T23:51:15.31818Z","end":"2026-07-23T23:51:15.773891Z","steps":["trace[250395634] 'agreement among raft nodes before linearized reading' (duration: 455.5891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:15.774039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:15.318165Z","time spent":"455.861488ms","remote":"127.0.0.1:59058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-sxbf8\" "} {"level":"warn","ts":"2026-07-23T23:51:29.889877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.984975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k8bh9\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-07-23T23:51:29.889967Z","caller":"traceutil/trace.go:171","msg":"trace[1948886325] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k8bh9; range_end:; response_count:1; response_revision:749; }","duration":"471.11602ms","start":"2026-07-23T23:51:29.418831Z","end":"2026-07-23T23:51:29.889947Z","steps":["trace[1948886325] 'range keys from in-memory index tree' (duration: 470.796901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:51:29.890013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:51:29.418816Z","time spent":"471.186881ms","remote":"127.0.0.1:59058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k8bh9\" "} {"level":"info","ts":"2026-07-23T23:51:58.700344Z","caller":"traceutil/trace.go:171","msg":"trace[751972808] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"159.076076ms","start":"2026-07-23T23:51:58.541237Z","end":"2026-07-23T23:51:58.700313Z","steps":["trace[751972808] 'process raft request' (duration: 158.430609ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:25.227672Z","caller":"traceutil/trace.go:171","msg":"trace[1730695943] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"446.433388ms","start":"2026-07-23T23:52:24.78121Z","end":"2026-07-23T23:52:25.227643Z","steps":["trace[1730695943] 'process raft request' (duration: 446.195401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:25.227904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:24.781188Z","time spent":"446.612352ms","remote":"127.0.0.1:59122","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:52:25.23519Z","caller":"traceutil/trace.go:171","msg":"trace[990042545] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"453.591265ms","start":"2026-07-23T23:52:24.781574Z","end":"2026-07-23T23:52:25.235165Z","steps":["trace[990042545] 'process raft request' (duration: 453.41212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:25.235364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:24.781546Z","time spent":"453.7199ms","remote":"127.0.0.1:59122","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:52:25.235366Z","caller":"traceutil/trace.go:171","msg":"trace[870992997] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"432.910003ms","start":"2026-07-23T23:52:24.802433Z","end":"2026-07-23T23:52:25.235343Z","steps":["trace[870992997] 'process raft request' (duration: 432.690907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:25.235472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:24.802419Z","time spent":"432.997396ms","remote":"127.0.0.1:59122","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:52:25.235348Z","caller":"traceutil/trace.go:171","msg":"trace[1155777555] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1074; }","duration":"248.39167ms","start":"2026-07-23T23:52:24.986934Z","end":"2026-07-23T23:52:25.235325Z","steps":["trace[1155777555] 'read index received' (duration: 240.402389ms)","trace[1155777555] 'applied index is now lower than readState.Index' (duration: 7.987691ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:25.235533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.588435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T23:52:25.235574Z","caller":"traceutil/trace.go:171","msg":"trace[1111279434] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1038; }","duration":"248.690528ms","start":"2026-07-23T23:52:24.986875Z","end":"2026-07-23T23:52:25.235566Z","steps":["trace[1111279434] 'agreement among raft nodes before linearized reading' (duration: 248.523964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:25.235822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.274985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:52:25.235877Z","caller":"traceutil/trace.go:171","msg":"trace[1069602780] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1038; }","duration":"174.345316ms","start":"2026-07-23T23:52:25.061519Z","end":"2026-07-23T23:52:25.235865Z","steps":["trace[1069602780] 'agreement among raft nodes before linearized reading' (duration: 174.239064ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:32.961858Z","caller":"traceutil/trace.go:171","msg":"trace[2121247674] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"148.620421ms","start":"2026-07-23T23:52:32.813209Z","end":"2026-07-23T23:52:32.96183Z","steps":["trace[2121247674] 'process raft request' (duration: 148.339544ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:33.41164Z","caller":"traceutil/trace.go:171","msg":"trace[1745902466] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"120.227555ms","start":"2026-07-23T23:52:33.291385Z","end":"2026-07-23T23:52:33.411612Z","steps":["trace[1745902466] 'read index received' (duration: 109.33625ms)","trace[1745902466] 'applied index is now lower than readState.Index' (duration: 10.889665ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:33.411826Z","caller":"traceutil/trace.go:171","msg":"trace[1446318101] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"150.759858ms","start":"2026-07-23T23:52:33.261051Z","end":"2026-07-23T23:52:33.411811Z","steps":["trace[1446318101] 'process raft request' (duration: 139.650307ms)","trace[1446318101] 'compare' (duration: 10.780482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:52:33.411845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.472994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:52:33.412063Z","caller":"traceutil/trace.go:171","msg":"trace[2104814885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"133.746711ms","start":"2026-07-23T23:52:33.278295Z","end":"2026-07-23T23:52:33.412042Z","steps":["trace[2104814885] 'agreement among raft nodes before linearized reading' (duration: 133.460394ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:33.486257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.089121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T23:52:33.486314Z","caller":"traceutil/trace.go:171","msg":"trace[1557440905] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1065; }","duration":"187.197673ms","start":"2026-07-23T23:52:33.299104Z","end":"2026-07-23T23:52:33.486302Z","steps":["trace[1557440905] 'agreement among raft nodes before linearized reading' (duration: 187.014889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:33.486678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.723194ms","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:52:33.486861Z","caller":"traceutil/trace.go:171","msg":"trace[733488951] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"108.973311ms","start":"2026-07-23T23:52:33.377862Z","end":"2026-07-23T23:52:33.486835Z","steps":["trace[733488951] 'agreement among raft nodes before linearized reading' (duration: 108.325954ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:52:33.486728Z","caller":"traceutil/trace.go:171","msg":"trace[1502690609] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"190.216424ms","start":"2026-07-23T23:52:33.295947Z","end":"2026-07-23T23:52:33.486163Z","steps":["trace[1502690609] 'process raft request' (duration: 189.896416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:49.512451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221914493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:52:49.51252Z","caller":"traceutil/trace.go:171","msg":"trace[1036018544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1165; }","duration":"1.222033656s","start":"2026-07-23T23:52:48.29047Z","end":"2026-07-23T23:52:49.512503Z","steps":["trace[1036018544] 'range keys from in-memory index tree' (duration: 1.221817171s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:49.512552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:48.29045Z","time spent":"1.222094318s","remote":"127.0.0.1:58862","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:52:49.512666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.566219ms","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:52:49.512735Z","caller":"traceutil/trace.go:171","msg":"trace[2074418040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1165; }","duration":"396.690592ms","start":"2026-07-23T23:52:49.116024Z","end":"2026-07-23T23:52:49.512715Z","steps":["trace[2074418040] 'range keys from in-memory index tree' (duration: 396.396746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:49.512773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:52:49.116001Z","time spent":"396.763715ms","remote":"127.0.0.1:59122","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:52:49.527559Z","caller":"traceutil/trace.go:171","msg":"trace[701497097] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1211; }","duration":"167.073716ms","start":"2026-07-23T23:52:49.360465Z","end":"2026-07-23T23:52:49.527539Z","steps":["trace[701497097] 'read index received' (duration: 166.944373ms)","trace[701497097] 'applied index is now lower than readState.Index' (duration: 128.083µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:52:49.527641Z","caller":"traceutil/trace.go:171","msg":"trace[292439999] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"181.142925ms","start":"2026-07-23T23:52:49.346468Z","end":"2026-07-23T23:52:49.527611Z","steps":["trace[292439999] 'process raft request' (duration: 180.901789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:52:49.527731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.2479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:52:49.527796Z","caller":"traceutil/trace.go:171","msg":"trace[697708666] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1166; }","duration":"167.341163ms","start":"2026-07-23T23:52:49.360424Z","end":"2026-07-23T23:52:49.527765Z","steps":["trace[697708666] 'agreement among raft nodes before linearized reading' (duration: 167.193499ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:03.877664Z","caller":"traceutil/trace.go:171","msg":"trace[1447965939] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"267.799396ms","start":"2026-07-23T23:53:03.60984Z","end":"2026-07-23T23:53:03.87764Z","steps":["trace[1447965939] 'read index received' (duration: 232.076188ms)","trace[1447965939] 'applied index is now lower than readState.Index' (duration: 35.722358ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:03.877785Z","caller":"traceutil/trace.go:171","msg":"trace[41989392] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"269.146051ms","start":"2026-07-23T23:53:03.608625Z","end":"2026-07-23T23:53:03.877771Z","steps":["trace[41989392] 'process raft request' (duration: 233.29171ms)","trace[41989392] 'compare' (duration: 35.584924ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:03.877934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.022977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:03.878023Z","caller":"traceutil/trace.go:171","msg":"trace[1434004577] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1221; }","duration":"240.180871ms","start":"2026-07-23T23:53:03.637822Z","end":"2026-07-23T23:53:03.878003Z","steps":["trace[1434004577] 'agreement among raft nodes before linearized reading' (duration: 240.016597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:03.878114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.322021ms","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:03.87822Z","caller":"traceutil/trace.go:171","msg":"trace[424689503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"132.484986ms","start":"2026-07-23T23:53:03.745712Z","end":"2026-07-23T23:53:03.878197Z","steps":["trace[424689503] 'agreement among raft nodes before linearized reading' (duration: 132.25755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:03.878355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.708598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T23:53:03.878401Z","caller":"traceutil/trace.go:171","msg":"trace[111752843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"210.793151ms","start":"2026-07-23T23:53:03.667598Z","end":"2026-07-23T23:53:03.878391Z","steps":["trace[111752843] 'agreement among raft nodes before linearized reading' (duration: 210.634436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:03.87858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.039604ms","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:03.878636Z","caller":"traceutil/trace.go:171","msg":"trace[1918456967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1221; }","duration":"233.116186ms","start":"2026-07-23T23:53:03.645505Z","end":"2026-07-23T23:53:03.878621Z","steps":["trace[1918456967] 'agreement among raft nodes before linearized reading' (duration: 232.996463ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:03.878671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.808743ms","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:03.878809Z","caller":"traceutil/trace.go:171","msg":"trace[84011911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"268.948986ms","start":"2026-07-23T23:53:03.609811Z","end":"2026-07-23T23:53:03.87876Z","steps":["trace[84011911] 'agreement among raft nodes before linearized reading' (duration: 268.574877ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:07.727676Z","caller":"traceutil/trace.go:171","msg":"trace[951278295] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"128.803569ms","start":"2026-07-23T23:53:07.598838Z","end":"2026-07-23T23:53:07.727642Z","steps":["trace[951278295] 'process raft request' (duration: 128.626505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:08.508446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.153204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:53:08.50852Z","caller":"traceutil/trace.go:171","msg":"trace[1168714125] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1266; }","duration":"295.266116ms","start":"2026-07-23T23:53:08.213235Z","end":"2026-07-23T23:53:08.508501Z","steps":["trace[1168714125] 'range keys from in-memory index tree' (duration: 295.085791ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:09.269878Z","caller":"traceutil/trace.go:171","msg":"trace[855701160] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"757.446951ms","start":"2026-07-23T23:53:08.512415Z","end":"2026-07-23T23:53:09.269862Z","steps":["trace[855701160] 'process raft request' (duration: 757.310957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:09.270002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:08.512401Z","time spent":"757.559514ms","remote":"127.0.0.1:59122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:53:09.291373Z","caller":"traceutil/trace.go:171","msg":"trace[1514387777] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"763.88768ms","start":"2026-07-23T23:53:08.527452Z","end":"2026-07-23T23:53:09.29134Z","steps":["trace[1514387777] 'process raft request' (duration: 763.649394ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:09.291371Z","caller":"traceutil/trace.go:171","msg":"trace[563634600] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1316; }","duration":"172.386202ms","start":"2026-07-23T23:53:09.118953Z","end":"2026-07-23T23:53:09.291339Z","steps":["trace[563634600] 'read index received' (duration: 150.852508ms)","trace[563634600] 'applied index is now lower than readState.Index' (duration: 21.532024ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:09.291455Z","caller":"traceutil/trace.go:171","msg":"trace[89484139] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"503.213611ms","start":"2026-07-23T23:53:08.788222Z","end":"2026-07-23T23:53:09.291436Z","steps":["trace[89484139] 'process raft request' (duration: 503.031826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:09.291535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:08.527429Z","time spent":"764.018794ms","remote":"127.0.0.1:58944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:53:09.291591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:08.788195Z","time spent":"503.303854ms","remote":"127.0.0.1:59122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:53:09.291661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.67937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-07-23T23:53:09.291758Z","caller":"traceutil/trace.go:171","msg":"trace[316053218] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1269; }","duration":"172.828934ms","start":"2026-07-23T23:53:09.118908Z","end":"2026-07-23T23:53:09.291737Z","steps":["trace[316053218] 'agreement among raft nodes before linearized reading' (duration: 172.563808ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:09.939887Z","caller":"traceutil/trace.go:171","msg":"trace[1091188149] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"206.491518ms","start":"2026-07-23T23:53:09.733368Z","end":"2026-07-23T23:53:09.93986Z","steps":["trace[1091188149] 'process raft request' (duration: 206.254611ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.1645Z","caller":"traceutil/trace.go:171","msg":"trace[849487186] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1323; }","duration":"235.132987ms","start":"2026-07-23T23:53:09.929338Z","end":"2026-07-23T23:53:10.164471Z","steps":["trace[849487186] 'read index received' (duration: 10.32141ms)","trace[849487186] 'applied index is now lower than readState.Index' (duration: 224.810437ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:53:10.164766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.414736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-23T23:53:10.164815Z","caller":"traceutil/trace.go:171","msg":"trace[1626148373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1275; }","duration":"235.521729ms","start":"2026-07-23T23:53:09.92928Z","end":"2026-07-23T23:53:10.164801Z","steps":["trace[1626148373] 'agreement among raft nodes before linearized reading' (duration: 235.347784ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.16463Z","caller":"traceutil/trace.go:171","msg":"trace[856328671] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"265.360292ms","start":"2026-07-23T23:53:09.89924Z","end":"2026-07-23T23:53:10.1646Z","steps":["trace[856328671] 'process raft request' (duration: 260.208876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:10.164983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.479317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T23:53:10.165089Z","caller":"traceutil/trace.go:171","msg":"trace[1980070507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1275; }","duration":"190.642831ms","start":"2026-07-23T23:53:09.974428Z","end":"2026-07-23T23:53:10.165071Z","steps":["trace[1980070507] 'agreement among raft nodes before linearized reading' (duration: 190.346024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:10.165211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.111009ms","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:10.16525Z","caller":"traceutil/trace.go:171","msg":"trace[587133898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"182.175649ms","start":"2026-07-23T23:53:09.983064Z","end":"2026-07-23T23:53:10.16524Z","steps":["trace[587133898] 'agreement among raft nodes before linearized reading' (duration: 182.081036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:10.165453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.144339ms","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:53:10.16546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.664472ms","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:10.165492Z","caller":"traceutil/trace.go:171","msg":"trace[1360846006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"166.215261ms","start":"2026-07-23T23:53:09.999269Z","end":"2026-07-23T23:53:10.165484Z","steps":["trace[1360846006] 'agreement among raft nodes before linearized reading' (duration: 166.119948ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.16555Z","caller":"traceutil/trace.go:171","msg":"trace[1685331792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"182.732244ms","start":"2026-07-23T23:53:09.982755Z","end":"2026-07-23T23:53:10.165487Z","steps":["trace[1685331792] 'agreement among raft nodes before linearized reading' (duration: 182.56969ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.416036Z","caller":"traceutil/trace.go:171","msg":"trace[1598202892] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"245.739707ms","start":"2026-07-23T23:53:10.170272Z","end":"2026-07-23T23:53:10.416012Z","steps":["trace[1598202892] 'process raft request' (duration: 243.584841ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.416423Z","caller":"traceutil/trace.go:171","msg":"trace[266217899] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"245.794738ms","start":"2026-07-23T23:53:10.170616Z","end":"2026-07-23T23:53:10.416411Z","steps":["trace[266217899] 'process raft request' (duration: 245.356327ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.41666Z","caller":"traceutil/trace.go:171","msg":"trace[127405559] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"245.85228ms","start":"2026-07-23T23:53:10.170797Z","end":"2026-07-23T23:53:10.41665Z","steps":["trace[127405559] 'process raft request' (duration: 245.4991ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:10.416461Z","caller":"traceutil/trace.go:171","msg":"trace[1726113852] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"244.488824ms","start":"2026-07-23T23:53:10.171948Z","end":"2026-07-23T23:53:10.416437Z","steps":["trace[1726113852] 'process raft request' (duration: 244.450603ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:53:18.204136Z","caller":"traceutil/trace.go:171","msg":"trace[6501909] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"696.534803ms","start":"2026-07-23T23:53:17.507572Z","end":"2026-07-23T23:53:18.204107Z","steps":["trace[6501909] 'process raft request' (duration: 696.351319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:18.204305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:17.507553Z","time spent":"696.666967ms","remote":"127.0.0.1:59122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:53:18.467535Z","caller":"traceutil/trace.go:171","msg":"trace[789300077] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1379; }","duration":"213.356326ms","start":"2026-07-23T23:53:18.254153Z","end":"2026-07-23T23:53:18.467509Z","steps":["trace[789300077] 'read index received' (duration: 213.09906ms)","trace[789300077] 'applied index is now lower than readState.Index' (duration: 256.086µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:53:18.467638Z","caller":"traceutil/trace.go:171","msg":"trace[1984153255] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"409.224565ms","start":"2026-07-23T23:53:18.058372Z","end":"2026-07-23T23:53:18.467597Z","steps":["trace[1984153255] 'process raft request' (duration: 408.968649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:18.4679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.725946ms","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:18.467962Z","caller":"traceutil/trace.go:171","msg":"trace[2108801827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1328; }","duration":"213.838889ms","start":"2026-07-23T23:53:18.254111Z","end":"2026-07-23T23:53:18.46795Z","steps":["trace[2108801827] 'agreement among raft nodes before linearized reading' (duration: 213.600163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:18.46809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.195633ms","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:18.468337Z","caller":"traceutil/trace.go:171","msg":"trace[2018121024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1328; }","duration":"189.46336ms","start":"2026-07-23T23:53:18.278858Z","end":"2026-07-23T23:53:18.468321Z","steps":["trace[2018121024] 'agreement among raft nodes before linearized reading' (duration: 189.188993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:53:18.468189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.735423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:53:18.468202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:53:18.058335Z","time spent":"409.564814ms","remote":"127.0.0.1:59122","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:53:18.4687Z","caller":"traceutil/trace.go:171","msg":"trace[1484051083] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1328; }","duration":"138.215165ms","start":"2026-07-23T23:53:18.330394Z","end":"2026-07-23T23:53:18.468609Z","steps":["trace[1484051083] 'agreement among raft nodes before linearized reading' (duration: 137.741243ms)"],"step_count":1}