{"level":"warn","ts":"2026-04-08T22:54:30.801099Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T22:54:30.80121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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://162.253.55.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T22:54:30.801286Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T22:54:30.801316Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-08T22:54:30.801343Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T22:54:30.801982Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-04-08T22:54:30.802071Z","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://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T22:54:30.805978Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.695116ms"} {"level":"info","ts":"2026-04-08T22:54:30.811578Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-04-08T22:54:30.811677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T22:54:30.811709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-04-08T22:54:30.811736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T22:54:30.811758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-04-08T22:54:30.811799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-04-08T22:54:30.820975Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T22:54:30.822703Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T22:54:30.823923Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-08T22:54:30.826128Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T22:54:30.826662Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T22:54:30.826975Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T22:54:30.827042Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T22:54:30.827056Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T22:54:30.827324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-04-08T22:54:30.827784Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-08T22:54:30.830375Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T22:54:30.830459Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-08T22:54:30.830552Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-08T22:54:30.830758Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T22:54:30.830813Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T22:54:31.312803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T22:54:31.31288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T22:54:31.312904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-04-08T22:54:31.312925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-04-08T22:54:31.312936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-08T22:54:31.312953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-04-08T22:54:31.312969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-08T22:54:31.313767Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:54:31.314454Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:54:31.314457Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T22:54:31.314587Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:54:31.314778Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:54:31.314913Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:54:31.31496Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:54:31.31504Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T22:54:31.315216Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T22:54:31.319522Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T22:54:31.326525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-04-08T22:55:01.202598Z","caller":"traceutil/trace.go:171","msg":"trace[1966244126] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"370.428531ms","start":"2026-04-08T22:55:00.832145Z","end":"2026-04-08T22:55:01.202573Z","steps":["trace[1966244126] 'process raft request' (duration: 370.274358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.203071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.832125Z","time spent":"370.557655ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.270856Z","caller":"traceutil/trace.go:171","msg":"trace[1063931270] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"426.405186ms","start":"2026-04-08T22:55:00.844428Z","end":"2026-04-08T22:55:01.270833Z","steps":["trace[1063931270] 'process raft request' (duration: 426.279973ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.270856Z","caller":"traceutil/trace.go:171","msg":"trace[1963672624] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"435.171753ms","start":"2026-04-08T22:55:00.835655Z","end":"2026-04-08T22:55:01.270826Z","steps":["trace[1963672624] 'process raft request' (duration: 434.936687ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.27101Z","caller":"traceutil/trace.go:171","msg":"trace[1531760042] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"396.65449ms","start":"2026-04-08T22:55:00.874349Z","end":"2026-04-08T22:55:01.271004Z","steps":["trace[1531760042] 'process raft request' (duration: 396.446055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.271043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.874337Z","time spent":"396.691861ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.271125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.835505Z","time spent":"435.543411ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.271202Z","caller":"traceutil/trace.go:171","msg":"trace[1688614877] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"393.743608ms","start":"2026-04-08T22:55:00.877431Z","end":"2026-04-08T22:55:01.271174Z","steps":["trace[1688614877] 'process raft request' (duration: 393.45333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.270975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.844409Z","time spent":"426.509958ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.271337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.877426Z","time spent":"393.833861ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.271388Z","caller":"traceutil/trace.go:171","msg":"trace[1928352489] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"380.852509ms","start":"2026-04-08T22:55:00.89044Z","end":"2026-04-08T22:55:01.271292Z","steps":["trace[1928352489] 'process raft request' (duration: 380.539241ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.271445Z","caller":"traceutil/trace.go:171","msg":"trace[437050222] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"394.048817ms","start":"2026-04-08T22:55:00.87738Z","end":"2026-04-08T22:55:01.271429Z","steps":["trace[437050222] 'process raft request' (duration: 393.452721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.271487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.877368Z","time spent":"394.099498ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.27156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.890366Z","time spent":"381.109606ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.27166Z","caller":"traceutil/trace.go:171","msg":"trace[295642803] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"376.607165ms","start":"2026-04-08T22:55:00.894987Z","end":"2026-04-08T22:55:01.271594Z","steps":["trace[295642803] 'process raft request' (duration: 376.05666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.27176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.894961Z","time spent":"376.764849ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.27183Z","caller":"traceutil/trace.go:171","msg":"trace[2118943685] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"365.48864ms","start":"2026-04-08T22:55:00.906331Z","end":"2026-04-08T22:55:01.271819Z","steps":["trace[2118943685] 'process raft request' (duration: 364.827163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.271874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.906315Z","time spent":"365.540151ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.27159Z","caller":"traceutil/trace.go:171","msg":"trace[1375835249] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"393.636587ms","start":"2026-04-08T22:55:00.877661Z","end":"2026-04-08T22:55:01.271297Z","steps":["trace[1375835249] 'process raft request' (duration: 393.278747ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.272158Z","caller":"traceutil/trace.go:171","msg":"trace[955349120] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"400.497166ms","start":"2026-04-08T22:55:00.871618Z","end":"2026-04-08T22:55:01.272115Z","steps":["trace[955349120] 'process raft request' (duration: 399.143541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.272287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.871594Z","time spent":"400.65425ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.272391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.877654Z","time spent":"394.546539ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.272588Z","caller":"traceutil/trace.go:171","msg":"trace[417566160] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"251.728326ms","start":"2026-04-08T22:55:01.020849Z","end":"2026-04-08T22:55:01.272577Z","steps":["trace[417566160] 'process raft request' (duration: 250.854094ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.272578Z","caller":"traceutil/trace.go:171","msg":"trace[1307983394] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:483; }","duration":"357.207415ms","start":"2026-04-08T22:55:00.915338Z","end":"2026-04-08T22:55:01.272546Z","steps":["trace[1307983394] 'read index received' (duration: 287.078671ms)","trace[1307983394] 'applied index is now lower than readState.Index' (duration: 70.127224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:55:01.273951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.558648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T22:55:01.274043Z","caller":"traceutil/trace.go:171","msg":"trace[300899375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:477; }","duration":"358.724742ms","start":"2026-04-08T22:55:00.915306Z","end":"2026-04-08T22:55:01.274031Z","steps":["trace[300899375] 'agreement among raft nodes before linearized reading' (duration: 357.323708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.274924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:00.91529Z","time spent":"359.617016ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T22:55:01.887234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782675928264449828,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T22:55:01.934883Z","caller":"traceutil/trace.go:171","msg":"trace[978898374] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"725.588306ms","start":"2026-04-08T22:55:01.209264Z","end":"2026-04-08T22:55:01.934853Z","steps":["trace[978898374] 'process raft request' (duration: 712.233977ms)","trace[978898374] 'compare' (duration: 13.148214ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:01.935027Z","caller":"traceutil/trace.go:171","msg":"trace[1413533230] transaction","detail":"{read_only:false; number_of_response:1; response_revision:479; }","duration":"724.269093ms","start":"2026-04-08T22:55:01.210702Z","end":"2026-04-08T22:55:01.934971Z","steps":["trace[1413533230] 'process raft request' (duration: 724.223782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.935061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.209232Z","time spent":"725.72853ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.935105Z","caller":"traceutil/trace.go:171","msg":"trace[1777309018] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"724.432297ms","start":"2026-04-08T22:55:01.210624Z","end":"2026-04-08T22:55:01.935056Z","steps":["trace[1777309018] 'process raft request' (duration: 724.238373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.935328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.210671Z","time spent":"724.406067ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:01.9354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.210603Z","time spent":"724.579832ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:01.942926Z","caller":"traceutil/trace.go:171","msg":"trace[671675777] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"657.941884ms","start":"2026-04-08T22:55:01.284949Z","end":"2026-04-08T22:55:01.942891Z","steps":["trace[671675777] 'process raft request' (duration: 657.78408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.284921Z","time spent":"658.114968ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.943206Z","caller":"traceutil/trace.go:171","msg":"trace[1286187733] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:495; }","duration":"557.000876ms","start":"2026-04-08T22:55:01.38619Z","end":"2026-04-08T22:55:01.94319Z","steps":["trace[1286187733] 'read index received' (duration: 535.396242ms)","trace[1286187733] 'applied index is now lower than readState.Index' (duration: 21.603844ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:01.94325Z","caller":"traceutil/trace.go:171","msg":"trace[875588418] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"657.859281ms","start":"2026-04-08T22:55:01.285371Z","end":"2026-04-08T22:55:01.943231Z","steps":["trace[875588418] 'process raft request' (duration: 657.44078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.285353Z","time spent":"657.956694ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:01.943427Z","caller":"traceutil/trace.go:171","msg":"trace[112281120] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"657.316188ms","start":"2026-04-08T22:55:01.2861Z","end":"2026-04-08T22:55:01.943417Z","steps":["trace[112281120] 'process raft request' (duration: 656.813976ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.943473Z","caller":"traceutil/trace.go:171","msg":"trace[673809515] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"658.067686ms","start":"2026-04-08T22:55:01.285396Z","end":"2026-04-08T22:55:01.943464Z","steps":["trace[673809515] 'process raft request' (duration: 657.458121ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.943509Z","caller":"traceutil/trace.go:171","msg":"trace[688071355] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"637.789474ms","start":"2026-04-08T22:55:01.305706Z","end":"2026-04-08T22:55:01.943496Z","steps":["trace[688071355] 'process raft request' (duration: 637.420785ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.943552Z","caller":"traceutil/trace.go:171","msg":"trace[519236861] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"599.713713ms","start":"2026-04-08T22:55:01.34383Z","end":"2026-04-08T22:55:01.943544Z","steps":["trace[519236861] 'process raft request' (duration: 599.338144ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:01.943584Z","caller":"traceutil/trace.go:171","msg":"trace[293173830] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"644.591514ms","start":"2026-04-08T22:55:01.29898Z","end":"2026-04-08T22:55:01.943571Z","steps":["trace[293173830] 'process raft request' (duration: 643.988128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.305687Z","time spent":"637.865226ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:01.943626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.438898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:55:01.943636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.29896Z","time spent":"644.650266ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:01.943654Z","caller":"traceutil/trace.go:171","msg":"trace[1662751104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"557.50773ms","start":"2026-04-08T22:55:01.386139Z","end":"2026-04-08T22:55:01.943647Z","steps":["trace[1662751104] 'agreement among raft nodes before linearized reading' (duration: 557.468119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.386117Z","time spent":"557.55827ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T22:55:01.943691Z","caller":"traceutil/trace.go:171","msg":"trace[1068053213] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"644.624786ms","start":"2026-04-08T22:55:01.299059Z","end":"2026-04-08T22:55:01.943684Z","steps":["trace[1068053213] 'process raft request' (duration: 644.02309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.286084Z","time spent":"657.370129ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:01.94374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.299035Z","time spent":"644.681446ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:01.943699Z","caller":"traceutil/trace.go:171","msg":"trace[1976460948] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"646.946172ms","start":"2026-04-08T22:55:01.296746Z","end":"2026-04-08T22:55:01.943692Z","steps":["trace[1976460948] 'process raft request' (duration: 646.197893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.943588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.343756Z","time spent":"599.813626ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.943784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.296732Z","time spent":"647.035774ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.943521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.285376Z","time spent":"658.125307ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:55:01.944011Z","caller":"traceutil/trace.go:171","msg":"trace[223395845] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"657.598455ms","start":"2026-04-08T22:55:01.285564Z","end":"2026-04-08T22:55:01.943163Z","steps":["trace[223395845] 'process raft request' (duration: 657.310218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.94408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.285534Z","time spent":"658.509817ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:01.957344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.316005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T22:55:01.957391Z","caller":"traceutil/trace.go:171","msg":"trace[2093695317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:489; }","duration":"274.406837ms","start":"2026-04-08T22:55:01.682973Z","end":"2026-04-08T22:55:01.95738Z","steps":["trace[2093695317] 'agreement among raft nodes before linearized reading' (duration: 274.318315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.957418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.728949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T22:55:01.957445Z","caller":"traceutil/trace.go:171","msg":"trace[1229545300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:489; }","duration":"446.786851ms","start":"2026-04-08T22:55:01.510651Z","end":"2026-04-08T22:55:01.957438Z","steps":["trace[1229545300] 'agreement among raft nodes before linearized reading' (duration: 446.73098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:01.957472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:01.510635Z","time spent":"446.831192ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T22:55:02.491102Z","caller":"traceutil/trace.go:171","msg":"trace[1180866782] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"120.445319ms","start":"2026-04-08T22:55:02.370612Z","end":"2026-04-08T22:55:02.491058Z","steps":["trace[1180866782] 'process raft request' (duration: 59.890151ms)","trace[1180866782] 'compare' (duration: 60.267201ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:08.156913Z","caller":"traceutil/trace.go:171","msg":"trace[575591079] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"193.66474ms","start":"2026-04-08T22:55:07.963225Z","end":"2026-04-08T22:55:08.15689Z","steps":["trace[575591079] 'read index received' (duration: 191.308982ms)","trace[575591079] 'applied index is now lower than readState.Index' (duration: 2.354838ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:08.15697Z","caller":"traceutil/trace.go:171","msg":"trace[1079616152] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"250.657909ms","start":"2026-04-08T22:55:07.906282Z","end":"2026-04-08T22:55:08.15694Z","steps":["trace[1079616152] 'process raft request' (duration: 249.182913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:08.157331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.076281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T22:55:08.157409Z","caller":"traceutil/trace.go:171","msg":"trace[480150710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"194.248335ms","start":"2026-04-08T22:55:07.963143Z","end":"2026-04-08T22:55:08.157391Z","steps":["trace[480150710] 'agreement among raft nodes before linearized reading' (duration: 193.932157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:08.15742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.599703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T22:55:08.157477Z","caller":"traceutil/trace.go:171","msg":"trace[638711670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"160.708406ms","start":"2026-04-08T22:55:07.996753Z","end":"2026-04-08T22:55:08.157462Z","steps":["trace[638711670] 'agreement among raft nodes before linearized reading' (duration: 160.562142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:08.157482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.669429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T22:55:08.157574Z","caller":"traceutil/trace.go:171","msg":"trace[247649649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"159.813903ms","start":"2026-04-08T22:55:07.997737Z","end":"2026-04-08T22:55:08.157551Z","steps":["trace[247649649] 'agreement among raft nodes before linearized reading' (duration: 159.586727ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:08.548896Z","caller":"traceutil/trace.go:171","msg":"trace[436630222] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"383.277949ms","start":"2026-04-08T22:55:08.165592Z","end":"2026-04-08T22:55:08.54887Z","steps":["trace[436630222] 'process raft request' (duration: 347.922835ms)","trace[436630222] 'compare' (duration: 35.046826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:55:08.549031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.165578Z","time spent":"383.388792ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:09.721163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.490367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:55:09.721307Z","caller":"traceutil/trace.go:171","msg":"trace[1919194964] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:594; }","duration":"1.33625279s","start":"2026-04-08T22:55:08.385035Z","end":"2026-04-08T22:55:09.721288Z","steps":["trace[1919194964] 'read index received' (duration: 128.536679ms)","trace[1919194964] 'applied index is now lower than readState.Index' (duration: 1.207715441s)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:09.721412Z","caller":"traceutil/trace.go:171","msg":"trace[1125444774] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.512919659s","start":"2026-04-08T22:55:08.208458Z","end":"2026-04-08T22:55:09.721378Z","steps":["trace[1125444774] 'process raft request' (duration: 1.512805586s)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:09.721453Z","caller":"traceutil/trace.go:171","msg":"trace[1619802988] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.550841438s","start":"2026-04-08T22:55:08.170563Z","end":"2026-04-08T22:55:09.721404Z","steps":["trace[1619802988] 'process raft request' (duration: 1.550666464s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:09.721552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258443625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6hjt6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-08T22:55:09.721485Z","caller":"traceutil/trace.go:171","msg":"trace[429283452] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.555770499s","start":"2026-04-08T22:55:08.165673Z","end":"2026-04-08T22:55:09.721443Z","steps":["trace[429283452] 'process raft request' (duration: 771.835401ms)","trace[429283452] 'compare' (duration: 783.295742ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:09.721575Z","caller":"traceutil/trace.go:171","msg":"trace[1629329123] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6hjt6; range_end:; response_count:1; response_revision:577; }","duration":"1.258491906s","start":"2026-04-08T22:55:08.463076Z","end":"2026-04-08T22:55:09.721568Z","steps":["trace[1629329123] 'agreement among raft nodes before linearized reading' (duration: 1.258408894s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:09.721566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.208432Z","time spent":"1.513073253s","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:55:09.721603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.463061Z","time spent":"1.258535218s","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-6hjt6\" "} {"level":"warn","ts":"2026-04-08T22:55:09.721637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.170545Z","time spent":"1.550990141s","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:09.721692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.165645Z","time spent":"1.555955544s","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:09.721763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.182419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T22:55:09.721462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.336428854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:09.721782Z","caller":"traceutil/trace.go:171","msg":"trace[522446534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"939.2378ms","start":"2026-04-08T22:55:08.782539Z","end":"2026-04-08T22:55:09.721777Z","steps":["trace[522446534] 'agreement among raft nodes before linearized reading' (duration: 939.183139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:09.721799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.78252Z","time spent":"939.27562ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T22:55:09.721806Z","caller":"traceutil/trace.go:171","msg":"trace[2126589465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"1.336822443s","start":"2026-04-08T22:55:08.38497Z","end":"2026-04-08T22:55:09.721793Z","steps":["trace[2126589465] 'agreement among raft nodes before linearized reading' (duration: 1.336471885s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:09.721847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:08.38495Z","time spent":"1.336882685s","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T22:55:10.016784Z","caller":"traceutil/trace.go:171","msg":"trace[29158874] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"288.706601ms","start":"2026-04-08T22:55:09.72805Z","end":"2026-04-08T22:55:10.016756Z","steps":["trace[29158874] 'process raft request' (duration: 270.199794ms)","trace[29158874] 'compare' (duration: 18.185199ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:10.016983Z","caller":"traceutil/trace.go:171","msg":"trace[1442102127] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"284.62889ms","start":"2026-04-08T22:55:09.732342Z","end":"2026-04-08T22:55:10.016971Z","steps":["trace[1442102127] 'read index received' (duration: 265.922188ms)","trace[1442102127] 'applied index is now lower than readState.Index' (duration: 18.705292ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:10.017162Z","caller":"traceutil/trace.go:171","msg":"trace[862230248] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"281.231336ms","start":"2026-04-08T22:55:09.735908Z","end":"2026-04-08T22:55:10.017139Z","steps":["trace[862230248] 'process raft request' (duration: 280.780025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.026998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.636728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:55:10.027017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.400538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.027046Z","caller":"traceutil/trace.go:171","msg":"trace[627284916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"294.72406ms","start":"2026-04-08T22:55:09.732312Z","end":"2026-04-08T22:55:10.027036Z","steps":["trace[627284916] 'agreement among raft nodes before linearized reading' (duration: 284.744342ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:10.027068Z","caller":"traceutil/trace.go:171","msg":"trace[1479394835] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:579; }","duration":"293.478129ms","start":"2026-04-08T22:55:09.733577Z","end":"2026-04-08T22:55:10.027056Z","steps":["trace[1479394835] 'agreement among raft nodes before linearized reading' (duration: 293.392817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.027318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.934665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:55:10.027335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.6941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.027358Z","caller":"traceutil/trace.go:171","msg":"trace[1626997114] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:579; }","duration":"123.73617ms","start":"2026-04-08T22:55:09.903615Z","end":"2026-04-08T22:55:10.027352Z","steps":["trace[1626997114] 'agreement among raft nodes before linearized reading' (duration: 123.699349ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:10.027343Z","caller":"traceutil/trace.go:171","msg":"trace[1195371475] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:579; }","duration":"106.980306ms","start":"2026-04-08T22:55:09.920357Z","end":"2026-04-08T22:55:10.027337Z","steps":["trace[1195371475] 'agreement among raft nodes before linearized reading' (duration: 106.924925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.027473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.104879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.027493Z","caller":"traceutil/trace.go:171","msg":"trace[1536955423] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:579; }","duration":"124.144011ms","start":"2026-04-08T22:55:09.903344Z","end":"2026-04-08T22:55:10.027488Z","steps":["trace[1536955423] 'agreement among raft nodes before linearized reading' (duration: 124.11227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.02757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.242172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.027595Z","caller":"traceutil/trace.go:171","msg":"trace[5069450] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:579; }","duration":"124.290554ms","start":"2026-04-08T22:55:09.903299Z","end":"2026-04-08T22:55:10.02759Z","steps":["trace[5069450] 'agreement among raft nodes before linearized reading' (duration: 124.256673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.027824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.526659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.027848Z","caller":"traceutil/trace.go:171","msg":"trace[307310969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:579; }","duration":"149.560629ms","start":"2026-04-08T22:55:09.878281Z","end":"2026-04-08T22:55:10.027842Z","steps":["trace[307310969] 'agreement among raft nodes before linearized reading' (duration: 149.524228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.028001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.726973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.028026Z","caller":"traceutil/trace.go:171","msg":"trace[730028883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:579; }","duration":"149.780175ms","start":"2026-04-08T22:55:09.878241Z","end":"2026-04-08T22:55:10.028021Z","steps":["trace[730028883] 'agreement among raft nodes before linearized reading' (duration: 149.742334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.028029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.214502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.028051Z","caller":"traceutil/trace.go:171","msg":"trace[1408392239] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:579; }","duration":"107.247982ms","start":"2026-04-08T22:55:09.920798Z","end":"2026-04-08T22:55:10.028046Z","steps":["trace[1408392239] 'agreement among raft nodes before linearized reading' (duration: 107.213161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:10.028115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.669763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:10.028133Z","caller":"traceutil/trace.go:171","msg":"trace[877454711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:579; }","duration":"107.699593ms","start":"2026-04-08T22:55:09.920429Z","end":"2026-04-08T22:55:10.028129Z","steps":["trace[877454711] 'agreement among raft nodes before linearized reading' (duration: 107.674513ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:11.784043Z","caller":"traceutil/trace.go:171","msg":"trace[240752493] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"100.077495ms","start":"2026-04-08T22:55:11.683934Z","end":"2026-04-08T22:55:11.784011Z","steps":["trace[240752493] 'process raft request' (duration: 99.89574ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:26.242112Z","caller":"traceutil/trace.go:171","msg":"trace[978332734] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"371.725324ms","start":"2026-04-08T22:55:25.870354Z","end":"2026-04-08T22:55:26.242079Z","steps":["trace[978332734] 'process raft request' (duration: 371.519869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:26.242467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:25.870333Z","time spent":"371.880447ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:26.391668Z","caller":"traceutil/trace.go:171","msg":"trace[1120914138] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:767; }","duration":"298.052552ms","start":"2026-04-08T22:55:26.09359Z","end":"2026-04-08T22:55:26.391642Z","steps":["trace[1120914138] 'read index received' (duration: 148.307988ms)","trace[1120914138] 'applied index is now lower than readState.Index' (duration: 149.743234ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:26.391718Z","caller":"traceutil/trace.go:171","msg":"trace[1661946866] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"520.603697ms","start":"2026-04-08T22:55:25.87109Z","end":"2026-04-08T22:55:26.391694Z","steps":["trace[1661946866] 'process raft request' (duration: 519.587831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:26.391857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:25.871067Z","time spent":"520.71056ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:26.391901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.300018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T22:55:26.391977Z","caller":"traceutil/trace.go:171","msg":"trace[1810331426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:743; }","duration":"298.438272ms","start":"2026-04-08T22:55:26.093524Z","end":"2026-04-08T22:55:26.391962Z","steps":["trace[1810331426] 'agreement among raft nodes before linearized reading' (duration: 298.246888ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:59.724521Z","caller":"traceutil/trace.go:171","msg":"trace[515088357] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"175.292408ms","start":"2026-04-08T22:55:59.549207Z","end":"2026-04-08T22:55:59.724499Z","steps":["trace[515088357] 'process raft request' (duration: 175.165335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:00.164705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.137597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:56:00.164875Z","caller":"traceutil/trace.go:171","msg":"trace[540771707] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"401.156186ms","start":"2026-04-08T22:55:59.763692Z","end":"2026-04-08T22:56:00.164848Z","steps":["trace[540771707] 'process raft request' (duration: 294.728222ms)","trace[540771707] 'compare' (duration: 105.935221ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:00.165024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:59.763661Z","time spent":"401.285109ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:20.234574Z","caller":"traceutil/trace.go:171","msg":"trace[1665911592] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"394.470632ms","start":"2026-04-08T22:56:19.840082Z","end":"2026-04-08T22:56:20.234552Z","steps":["trace[1665911592] 'process raft request' (duration: 394.325189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:20.234713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:19.840067Z","time spent":"394.576634ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:20.456777Z","caller":"traceutil/trace.go:171","msg":"trace[1291306626] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"198.706412ms","start":"2026-04-08T22:56:20.258054Z","end":"2026-04-08T22:56:20.45676Z","steps":["trace[1291306626] 'process raft request' (duration: 198.632521ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:20.456838Z","caller":"traceutil/trace.go:171","msg":"trace[1647026590] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1060; }","duration":"276.629808ms","start":"2026-04-08T22:56:20.180171Z","end":"2026-04-08T22:56:20.456801Z","steps":["trace[1647026590] 'read index received' (duration: 54.269888ms)","trace[1647026590] 'applied index is now lower than readState.Index' (duration: 222.35461ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:20.457031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.836534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:56:20.457062Z","caller":"traceutil/trace.go:171","msg":"trace[1165450624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1025; }","duration":"276.919346ms","start":"2026-04-08T22:56:20.180135Z","end":"2026-04-08T22:56:20.457054Z","steps":["trace[1165450624] 'agreement among raft nodes before linearized reading' (duration: 276.825193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:20.457192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.990037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:56:20.45723Z","caller":"traceutil/trace.go:171","msg":"trace[1784799128] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1025; }","duration":"172.0778ms","start":"2026-04-08T22:56:20.285144Z","end":"2026-04-08T22:56:20.457222Z","steps":["trace[1784799128] 'agreement among raft nodes before linearized reading' (duration: 172.004368ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:21.233954Z","caller":"traceutil/trace.go:171","msg":"trace[981138319] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"305.248329ms","start":"2026-04-08T22:56:20.928674Z","end":"2026-04-08T22:56:21.233922Z","steps":["trace[981138319] 'process raft request' (duration: 305.064453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:21.234138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:20.928651Z","time spent":"305.392132ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:24.354694Z","caller":"traceutil/trace.go:171","msg":"trace[1828926015] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"101.688059ms","start":"2026-04-08T22:56:24.25297Z","end":"2026-04-08T22:56:24.354658Z","steps":["trace[1828926015] 'process raft request' (duration: 101.457762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:25.039097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.296937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:56:25.039195Z","caller":"traceutil/trace.go:171","msg":"trace[566800233] linearizableReadLoop","detail":"{readStateIndex:1075; appliedIndex:1074; }","duration":"482.086485ms","start":"2026-04-08T22:56:24.557092Z","end":"2026-04-08T22:56:25.039178Z","steps":["trace[566800233] 'read index received' (duration: 141.480431ms)","trace[566800233] 'applied index is now lower than readState.Index' (duration: 340.604744ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:56:25.039277Z","caller":"traceutil/trace.go:171","msg":"trace[179384536] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"572.725633ms","start":"2026-04-08T22:56:24.466539Z","end":"2026-04-08T22:56:25.039265Z","steps":["trace[179384536] 'process raft request' (duration: 232.126379ms)","trace[179384536] 'compare' (duration: 340.103152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:25.039332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:24.466516Z","time spent":"572.785804ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:56:25.03971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.204112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T22:56:25.039763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.676549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-08T22:56:25.039772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.75978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-08T22:56:25.039809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.963934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-08T22:56:25.039812Z","caller":"traceutil/trace.go:171","msg":"trace[1625005390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1037; }","duration":"482.764271ms","start":"2026-04-08T22:56:24.557036Z","end":"2026-04-08T22:56:25.0398Z","steps":["trace[1625005390] 'agreement among raft nodes before linearized reading' (duration: 482.617248ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:25.039829Z","caller":"traceutil/trace.go:171","msg":"trace[61341118] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1037; }","duration":"316.873873ms","start":"2026-04-08T22:56:24.722941Z","end":"2026-04-08T22:56:25.039815Z","steps":["trace[61341118] 'agreement among raft nodes before linearized reading' (duration: 316.721889ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:25.039851Z","caller":"traceutil/trace.go:171","msg":"trace[1150409334] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:1037; }","duration":"393.055906ms","start":"2026-04-08T22:56:24.646786Z","end":"2026-04-08T22:56:25.039841Z","steps":["trace[1150409334] 'agreement among raft nodes before linearized reading' (duration: 392.762089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:25.039859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:24.557014Z","time spent":"482.835593ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T22:56:25.039862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:24.722918Z","time spent":"316.937215ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T22:56:25.039877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:24.646758Z","time spent":"393.113808ms","remote":"127.0.0.1:34422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.62\" "} {"level":"info","ts":"2026-04-08T22:56:25.039866Z","caller":"traceutil/trace.go:171","msg":"trace[1854725531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1037; }","duration":"306.327764ms","start":"2026-04-08T22:56:24.733463Z","end":"2026-04-08T22:56:25.039791Z","steps":["trace[1854725531] 'agreement among raft nodes before linearized reading' (duration: 306.118239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:25.039965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:24.733452Z","time spent":"306.503129ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T22:56:25.635024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.141486ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-08T22:56:25.635119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.040429Z","time spent":"594.686501ms","remote":"127.0.0.1:34422","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-08T22:56:25.783723Z","caller":"traceutil/trace.go:171","msg":"trace[629274770] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"739.959475ms","start":"2026-04-08T22:56:25.043737Z","end":"2026-04-08T22:56:25.783697Z","steps":["trace[629274770] 'process raft request' (duration: 739.826061ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:25.783744Z","caller":"traceutil/trace.go:171","msg":"trace[544372085] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"740.281274ms","start":"2026-04-08T22:56:25.043422Z","end":"2026-04-08T22:56:25.783703Z","steps":["trace[544372085] 'process raft request' (duration: 707.187234ms)","trace[544372085] 'compare' (duration: 32.786862ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:25.783889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.04373Z","time spent":"740.073467ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:25.784163Z","caller":"traceutil/trace.go:171","msg":"trace[1338446024] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"740.361734ms","start":"2026-04-08T22:56:25.043781Z","end":"2026-04-08T22:56:25.784143Z","steps":["trace[1338446024] 'process raft request' (duration: 739.863032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:25.784302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.043777Z","time spent":"740.450026ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:25.784471Z","caller":"traceutil/trace.go:171","msg":"trace[440767981] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"147.629012ms","start":"2026-04-08T22:56:25.636831Z","end":"2026-04-08T22:56:25.78446Z","steps":["trace[440767981] 'process raft request' (duration: 147.572611ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:25.784464Z","caller":"traceutil/trace.go:171","msg":"trace[1697658285] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"739.907663ms","start":"2026-04-08T22:56:25.044518Z","end":"2026-04-08T22:56:25.784426Z","steps":["trace[1697658285] 'process raft request' (duration: 739.537954ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:25.784573Z","caller":"traceutil/trace.go:171","msg":"trace[1057274803] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1075; }","duration":"488.705277ms","start":"2026-04-08T22:56:25.295847Z","end":"2026-04-08T22:56:25.784553Z","steps":["trace[1057274803] 'read index received' (duration: 51.952891ms)","trace[1057274803] 'applied index is now lower than readState.Index' (duration: 436.751006ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:25.784598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.044512Z","time spent":"740.027986ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:56:25.784763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.917682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T22:56:25.78482Z","caller":"traceutil/trace.go:171","msg":"trace[1816027776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1042; }","duration":"489.015934ms","start":"2026-04-08T22:56:25.295788Z","end":"2026-04-08T22:56:25.784804Z","steps":["trace[1816027776] 'agreement among raft nodes before linearized reading' (duration: 488.84259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:25.784862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.295768Z","time spent":"489.082677ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T22:56:25.784859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:25.043404Z","time spent":"740.412786ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:35.025473Z","caller":"traceutil/trace.go:171","msg":"trace[1655947208] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"123.84311ms","start":"2026-04-08T22:56:34.901592Z","end":"2026-04-08T22:56:35.025435Z","steps":["trace[1655947208] 'process raft request' (duration: 123.497492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:35.468303Z","caller":"traceutil/trace.go:171","msg":"trace[2001350030] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"123.623664ms","start":"2026-04-08T22:56:35.344655Z","end":"2026-04-08T22:56:35.468279Z","steps":["trace[2001350030] 'process raft request' (duration: 123.354928ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:35.67037Z","caller":"traceutil/trace.go:171","msg":"trace[401652146] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"197.745938ms","start":"2026-04-08T22:56:35.472601Z","end":"2026-04-08T22:56:35.670347Z","steps":["trace[401652146] 'process raft request' (duration: 197.601645ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:35.738102Z","caller":"traceutil/trace.go:171","msg":"trace[107407620] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"251.609876ms","start":"2026-04-08T22:56:35.486468Z","end":"2026-04-08T22:56:35.738078Z","steps":["trace[107407620] 'process raft request' (duration: 251.558015ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:35.73817Z","caller":"traceutil/trace.go:171","msg":"trace[1738612234] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"251.688938ms","start":"2026-04-08T22:56:35.486453Z","end":"2026-04-08T22:56:35.738142Z","steps":["trace[1738612234] 'process raft request' (duration: 251.442782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:40.3844Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782675928264451252,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T22:56:40.396562Z","caller":"traceutil/trace.go:171","msg":"trace[857883635] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"512.622602ms","start":"2026-04-08T22:56:39.883917Z","end":"2026-04-08T22:56:40.396539Z","steps":["trace[857883635] 'read index received' (duration: 512.423478ms)","trace[857883635] 'applied index is now lower than readState.Index' (duration: 198.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:56:40.396689Z","caller":"traceutil/trace.go:171","msg":"trace[1072349219] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"539.293295ms","start":"2026-04-08T22:56:39.857385Z","end":"2026-04-08T22:56:40.396679Z","steps":["trace[1072349219] 'process raft request' (duration: 539.011628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:40.396789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.10921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T22:56:40.396797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:39.85737Z","time spent":"539.352876ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:40.396832Z","caller":"traceutil/trace.go:171","msg":"trace[311087487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1137; }","duration":"512.197642ms","start":"2026-04-08T22:56:39.884622Z","end":"2026-04-08T22:56:40.39682Z","steps":["trace[311087487] 'agreement among raft nodes before linearized reading' (duration: 512.077879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:40.396865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:39.884609Z","time spent":"512.248033ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T22:56:40.396958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.053583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T22:56:40.396989Z","caller":"traceutil/trace.go:171","msg":"trace[95913579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1137; }","duration":"513.106044ms","start":"2026-04-08T22:56:39.883867Z","end":"2026-04-08T22:56:40.396973Z","steps":["trace[95913579] 'agreement among raft nodes before linearized reading' (duration: 513.055123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:40.397008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:39.883851Z","time spent":"513.152715ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T22:56:40.39718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.725352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T22:56:40.397223Z","caller":"traceutil/trace.go:171","msg":"trace[401590958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1137; }","duration":"509.783783ms","start":"2026-04-08T22:56:39.887429Z","end":"2026-04-08T22:56:40.397213Z","steps":["trace[401590958] 'agreement among raft nodes before linearized reading' (duration: 509.65943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:40.397261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:39.887421Z","time spent":"509.831204ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T22:56:40.559573Z","caller":"traceutil/trace.go:171","msg":"trace[242556870] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1179; }","duration":"127.722494ms","start":"2026-04-08T22:56:40.431832Z","end":"2026-04-08T22:56:40.559554Z","steps":["trace[242556870] 'read index received' (duration: 126.395342ms)","trace[242556870] 'applied index is now lower than readState.Index' (duration: 1.326062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:40.559718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.870598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T22:56:40.559738Z","caller":"traceutil/trace.go:171","msg":"trace[871350731] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1140; }","duration":"127.941209ms","start":"2026-04-08T22:56:40.43179Z","end":"2026-04-08T22:56:40.559732Z","steps":["trace[871350731] 'agreement among raft nodes before linearized reading' (duration: 127.831186ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:40.559845Z","caller":"traceutil/trace.go:171","msg":"trace[1507600335] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"158.328714ms","start":"2026-04-08T22:56:40.401507Z","end":"2026-04-08T22:56:40.559836Z","steps":["trace[1507600335] 'process raft request' (duration: 157.983415ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:40.559829Z","caller":"traceutil/trace.go:171","msg":"trace[1098602770] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"158.59467ms","start":"2026-04-08T22:56:40.401215Z","end":"2026-04-08T22:56:40.559809Z","steps":["trace[1098602770] 'process raft request' (duration: 157.001402ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:40.560117Z","caller":"traceutil/trace.go:171","msg":"trace[591109349] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"158.560139ms","start":"2026-04-08T22:56:40.401551Z","end":"2026-04-08T22:56:40.560111Z","steps":["trace[591109349] 'process raft request' (duration: 157.980015ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:52.813897Z","caller":"traceutil/trace.go:171","msg":"trace[85463949] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"174.40974ms","start":"2026-04-08T22:56:52.639455Z","end":"2026-04-08T22:56:52.813865Z","steps":["trace[85463949] 'process raft request' (duration: 100.761729ms)","trace[85463949] 'compare' (duration: 73.444895ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:56:52.813933Z","caller":"traceutil/trace.go:171","msg":"trace[1484857154] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"173.59941ms","start":"2026-04-08T22:56:52.64031Z","end":"2026-04-08T22:56:52.813909Z","steps":["trace[1484857154] 'process raft request' (duration: 173.484807ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:52.813973Z","caller":"traceutil/trace.go:171","msg":"trace[495094750] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"173.214591ms","start":"2026-04-08T22:56:52.640733Z","end":"2026-04-08T22:56:52.813947Z","steps":["trace[495094750] 'process raft request' (duration: 173.121618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:53.149598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.742899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:56:53.149688Z","caller":"traceutil/trace.go:171","msg":"trace[704555392] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1180; }","duration":"186.866522ms","start":"2026-04-08T22:56:52.962801Z","end":"2026-04-08T22:56:53.149667Z","steps":["trace[704555392] 'count revisions from in-memory index tree' (duration: 186.636086ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:55.023907Z","caller":"traceutil/trace.go:171","msg":"trace[1214584318] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"107.685247ms","start":"2026-04-08T22:56:54.916204Z","end":"2026-04-08T22:56:55.02389Z","steps":["trace[1214584318] 'process raft request' (duration: 107.548863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:55.700191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.744528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:56:55.700267Z","caller":"traceutil/trace.go:171","msg":"trace[675307535] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"314.31266ms","start":"2026-04-08T22:56:55.385944Z","end":"2026-04-08T22:56:55.700256Z","steps":["trace[675307535] 'read index received' (duration: 35.091µs)","trace[675307535] 'applied index is now lower than readState.Index' (duration: 314.276899ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:55.70033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.391921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:56:55.700347Z","caller":"traceutil/trace.go:171","msg":"trace[309284651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1208; }","duration":"314.435243ms","start":"2026-04-08T22:56:55.385907Z","end":"2026-04-08T22:56:55.700342Z","steps":["trace[309284651] 'agreement among raft nodes before linearized reading' (duration: 314.377461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:55.700367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:55.38589Z","time spent":"314.472423ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T22:56:55.700586Z","caller":"traceutil/trace.go:171","msg":"trace[61487129] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"475.687612ms","start":"2026-04-08T22:56:55.224889Z","end":"2026-04-08T22:56:55.700576Z","steps":["trace[61487129] 'process raft request' (duration: 158.488133ms)","trace[61487129] 'compare' (duration: 316.656386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:55.700627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:55.224874Z","time spent":"475.731613ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:56.546084Z","caller":"traceutil/trace.go:171","msg":"trace[1756419885] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"152.899296ms","start":"2026-04-08T22:56:56.393152Z","end":"2026-04-08T22:56:56.546052Z","steps":["trace[1756419885] 'process raft request' (duration: 152.518487ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:56.988864Z","caller":"traceutil/trace.go:171","msg":"trace[1535454838] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"434.023509ms","start":"2026-04-08T22:56:56.554815Z","end":"2026-04-08T22:56:56.988838Z","steps":["trace[1535454838] 'process raft request' (duration: 433.898046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.989031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:56.554805Z","time spent":"434.139742ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:56:56.989544Z","caller":"traceutil/trace.go:171","msg":"trace[1391314105] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"437.482113ms","start":"2026-04-08T22:56:56.551963Z","end":"2026-04-08T22:56:56.989445Z","steps":["trace[1391314105] 'process raft request' (duration: 431.826595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.989712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:56.551945Z","time spent":"437.693669ms","remote":"127.0.0.1:34460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:56:56.998442Z","caller":"traceutil/trace.go:171","msg":"trace[2055190399] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1260; }","duration":"350.260213ms","start":"2026-04-08T22:56:56.648169Z","end":"2026-04-08T22:56:56.998429Z","steps":["trace[2055190399] 'read index received' (duration: 335.632928ms)","trace[2055190399] 'applied index is now lower than readState.Index' (duration: 14.626415ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:56:56.998525Z","caller":"traceutil/trace.go:171","msg":"trace[1957993554] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"370.324241ms","start":"2026-04-08T22:56:56.628141Z","end":"2026-04-08T22:56:56.998466Z","steps":["trace[1957993554] 'process raft request' (duration: 370.197348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.998638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.629737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T22:56:56.998674Z","caller":"traceutil/trace.go:171","msg":"trace[713152548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"142.706179ms","start":"2026-04-08T22:56:56.85596Z","end":"2026-04-08T22:56:56.998666Z","steps":["trace[713152548] 'agreement among raft nodes before linearized reading' (duration: 142.570646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.998748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:56.628121Z","time spent":"370.523975ms","remote":"127.0.0.1:34460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:56:56.998743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.55304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T22:56:56.998809Z","caller":"traceutil/trace.go:171","msg":"trace[266539413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"350.670003ms","start":"2026-04-08T22:56:56.648122Z","end":"2026-04-08T22:56:56.998792Z","steps":["trace[266539413] 'agreement among raft nodes before linearized reading' (duration: 350.390326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.998836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.036227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-08T22:56:56.998851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:56.648103Z","time spent":"350.740185ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T22:56:56.99886Z","caller":"traceutil/trace.go:171","msg":"trace[685767714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1216; }","duration":"129.099758ms","start":"2026-04-08T22:56:56.869753Z","end":"2026-04-08T22:56:56.998853Z","steps":["trace[685767714] 'agreement among raft nodes before linearized reading' (duration: 129.037247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:56.998976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.345485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T22:56:56.998993Z","caller":"traceutil/trace.go:171","msg":"trace[1890581771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1216; }","duration":"129.383476ms","start":"2026-04-08T22:56:56.869605Z","end":"2026-04-08T22:56:56.998988Z","steps":["trace[1890581771] 'agreement among raft nodes before linearized reading' (duration: 129.331433ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:57.849338Z","caller":"traceutil/trace.go:171","msg":"trace[1555010250] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"142.75767ms","start":"2026-04-08T22:56:57.706556Z","end":"2026-04-08T22:56:57.849314Z","steps":["trace[1555010250] 'process raft request' (duration: 142.604006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:09.483442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.104379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:57:09.483605Z","caller":"traceutil/trace.go:171","msg":"trace[1739978297] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"326.336252ms","start":"2026-04-08T22:57:09.157242Z","end":"2026-04-08T22:57:09.483578Z","steps":["trace[1739978297] 'process raft request' (duration: 133.965216ms)","trace[1739978297] 'compare' (duration: 191.895324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:57:09.483692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.157222Z","time spent":"326.436814ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:57:09.793404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.857378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:57:09.79357Z","caller":"traceutil/trace.go:171","msg":"trace[1938178484] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"634.516683ms","start":"2026-04-08T22:57:09.159036Z","end":"2026-04-08T22:57:09.793552Z","steps":["trace[1938178484] 'process raft request' (duration: 634.463192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:09.793765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.159017Z","time spent":"634.717397ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:57:09.793632Z","caller":"traceutil/trace.go:171","msg":"trace[1106419491] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"636.08336ms","start":"2026-04-08T22:57:09.157507Z","end":"2026-04-08T22:57:09.793591Z","steps":["trace[1106419491] 'process raft request' (duration: 507.958545ms)","trace[1106419491] 'compare' (duration: 127.422008ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:57:09.794662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.157486Z","time spent":"637.025883ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:57:09.79652Z","caller":"traceutil/trace.go:171","msg":"trace[968065032] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1348; }","duration":"410.448557ms","start":"2026-04-08T22:57:09.386056Z","end":"2026-04-08T22:57:09.796505Z","steps":["trace[968065032] 'read index received' (duration: 279.533454ms)","trace[968065032] 'applied index is now lower than readState.Index' (duration: 130.914143ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:09.796538Z","caller":"traceutil/trace.go:171","msg":"trace[1966097429] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"418.329508ms","start":"2026-04-08T22:57:09.378197Z","end":"2026-04-08T22:57:09.796526Z","steps":["trace[1966097429] 'process raft request' (duration: 418.235766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:09.796658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.378172Z","time spent":"418.446981ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:57:09.796727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.626831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:57:09.796831Z","caller":"traceutil/trace.go:171","msg":"trace[1262150953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1302; }","duration":"410.793425ms","start":"2026-04-08T22:57:09.38602Z","end":"2026-04-08T22:57:09.796813Z","steps":["trace[1262150953] 'agreement among raft nodes before linearized reading' (duration: 410.606961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:09.796909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.386012Z","time spent":"410.885237ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T22:57:09.809796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.650611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-08T22:57:09.809855Z","caller":"traceutil/trace.go:171","msg":"trace[1844383019] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1302; }","duration":"412.751383ms","start":"2026-04-08T22:57:09.397089Z","end":"2026-04-08T22:57:09.80984Z","steps":["trace[1844383019] 'agreement among raft nodes before linearized reading' (duration: 412.585179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:09.809896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:09.397063Z","time spent":"412.822964ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-08T22:57:36.497557Z","caller":"traceutil/trace.go:171","msg":"trace[1362457887] linearizableReadLoop","detail":"{readStateIndex:1480; appliedIndex:1479; }","duration":"129.040017ms","start":"2026-04-08T22:57:36.368493Z","end":"2026-04-08T22:57:36.497533Z","steps":["trace[1362457887] 'read index received' (duration: 128.067173ms)","trace[1362457887] 'applied index is now lower than readState.Index' (duration: 971.594µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:36.497598Z","caller":"traceutil/trace.go:171","msg":"trace[586235539] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"349.391503ms","start":"2026-04-08T22:57:36.148187Z","end":"2026-04-08T22:57:36.497578Z","steps":["trace[586235539] 'process raft request' (duration: 348.376058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:36.497686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.17457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T22:57:36.497711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:36.148155Z","time spent":"349.496315ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:57:36.497731Z","caller":"traceutil/trace.go:171","msg":"trace[1364059215] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1425; }","duration":"129.241251ms","start":"2026-04-08T22:57:36.368481Z","end":"2026-04-08T22:57:36.497722Z","steps":["trace[1364059215] 'agreement among raft nodes before linearized reading' (duration: 129.147259ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:34.440713Z","caller":"traceutil/trace.go:171","msg":"trace[1819859549] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"191.268624ms","start":"2026-04-08T22:58:34.249399Z","end":"2026-04-08T22:58:34.440668Z","steps":["trace[1819859549] 'process raft request' (duration: 191.08487ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:34.441789Z","caller":"traceutil/trace.go:171","msg":"trace[315229240] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"125.891194ms","start":"2026-04-08T22:58:34.315883Z","end":"2026-04-08T22:58:34.441775Z","steps":["trace[315229240] 'process raft request' (duration: 125.458444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:03.127679Z","caller":"traceutil/trace.go:171","msg":"trace[46551363] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"222.234771ms","start":"2026-04-08T23:00:02.905422Z","end":"2026-04-08T23:00:03.127657Z","steps":["trace[46551363] 'read index received' (duration: 222.058086ms)","trace[46551363] 'applied index is now lower than readState.Index' (duration: 175.715µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:00:03.127753Z","caller":"traceutil/trace.go:171","msg":"trace[1835060337] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"367.93365ms","start":"2026-04-08T23:00:02.75979Z","end":"2026-04-08T23:00:03.127723Z","steps":["trace[1835060337] 'process raft request' (duration: 367.742015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:03.127879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:02.759769Z","time spent":"368.047404ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T23:00:03.12794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.509147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T23:00:03.127976Z","caller":"traceutil/trace.go:171","msg":"trace[46991373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2096; }","duration":"222.59956ms","start":"2026-04-08T23:00:02.905368Z","end":"2026-04-08T23:00:03.127967Z","steps":["trace[46991373] 'agreement among raft nodes before linearized reading' (duration: 222.377684ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:25.596559Z","caller":"traceutil/trace.go:171","msg":"trace[1740047887] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"339.826619ms","start":"2026-04-08T23:00:25.256705Z","end":"2026-04-08T23:00:25.596532Z","steps":["trace[1740047887] 'process raft request' (duration: 322.391806ms)","trace[1740047887] 'compare' (duration: 16.989372ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:00:25.59659Z","caller":"traceutil/trace.go:171","msg":"trace[1819075065] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2318; }","duration":"265.361913ms","start":"2026-04-08T23:00:25.331039Z","end":"2026-04-08T23:00:25.596401Z","steps":["trace[1819075065] 'read index received' (duration: 248.067623ms)","trace[1819075065] 'applied index is now lower than readState.Index' (duration: 17.29362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:00:25.596763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:25.256694Z","time spent":"339.959912ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T23:00:25.596839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.858105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:25.596862Z","caller":"traceutil/trace.go:171","msg":"trace[898792260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2229; }","duration":"210.935357ms","start":"2026-04-08T23:00:25.38592Z","end":"2026-04-08T23:00:25.596855Z","steps":["trace[898792260] 'agreement among raft nodes before linearized reading' (duration: 210.860835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:25.596849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.735572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:00:25.597007Z","caller":"traceutil/trace.go:171","msg":"trace[1423811901] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2229; }","duration":"265.982578ms","start":"2026-04-08T23:00:25.330977Z","end":"2026-04-08T23:00:25.59696Z","steps":["trace[1423811901] 'agreement among raft nodes before linearized reading' (duration: 265.707111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:25.597308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.534006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-08T23:00:25.59736Z","caller":"traceutil/trace.go:171","msg":"trace[1206559824] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2229; }","duration":"205.611078ms","start":"2026-04-08T23:00:25.391738Z","end":"2026-04-08T23:00:25.597349Z","steps":["trace[1206559824] 'agreement among raft nodes before linearized reading' (duration: 205.453674ms)"],"step_count":1}