{"level":"warn","ts":"2026-05-26T15:51:19.58926Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T15:51:19.589358Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.11:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.11:2380","--initial-cluster=instance=https://199.19.213.11:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.11:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.11: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-05-26T15:51:19.589436Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T15:51:19.589455Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.11:2380"]} {"level":"info","ts":"2026-05-26T15:51:19.589476Z","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-05-26T15:51:19.590318Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"]} {"level":"info","ts":"2026-05-26T15:51:19.590423Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.11: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-05-26T15:51:19.599273Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.591719ms"} {"level":"info","ts":"2026-05-26T15:51:19.703974Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ce8ad90e35537ee3","cluster-id":"3c17b62c6529d987"} {"level":"info","ts":"2026-05-26T15:51:19.704146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T15:51:19.704195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 0"} {"level":"info","ts":"2026-05-26T15:51:19.704217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ce8ad90e35537ee3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T15:51:19.70423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 1"} {"level":"info","ts":"2026-05-26T15:51:19.704315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"} {"level":"warn","ts":"2026-05-26T15:51:20.035007Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T15:51:20.07493Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T15:51:20.131687Z","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-05-26T15:51:20.18664Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ce8ad90e35537ee3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T15:51:20.187235Z","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-05-26T15:51:20.187333Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ce8ad90e35537ee3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T15:51:20.187435Z","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-05-26T15:51:20.187673Z","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-05-26T15:51:20.192603Z","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-05-26T15:51:20.192686Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.11:2380"} {"level":"info","ts":"2026-05-26T15:51:20.192769Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.11:2380"} {"level":"info","ts":"2026-05-26T15:51:20.193665Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ce8ad90e35537ee3","initial-advertise-peer-urls":["https://199.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T15:51:20.193721Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T15:51:20.23669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"} {"level":"info","ts":"2026-05-26T15:51:20.237223Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","added-peer-id":"ce8ad90e35537ee3","added-peer-peer-urls":["https://199.19.213.11:2380"]} {"level":"info","ts":"2026-05-26T15:51:21.018409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T15:51:21.01847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T15:51:21.018506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgPreVoteResp from ce8ad90e35537ee3 at term 1"} {"level":"info","ts":"2026-05-26T15:51:21.018524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became candidate at term 2"} {"level":"info","ts":"2026-05-26T15:51:21.018532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgVoteResp from ce8ad90e35537ee3 at term 2"} {"level":"info","ts":"2026-05-26T15:51:21.018544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became leader at term 2"} {"level":"info","ts":"2026-05-26T15:51:21.018553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ce8ad90e35537ee3 elected leader ce8ad90e35537ee3 at term 2"} {"level":"info","ts":"2026-05-26T15:51:21.020012Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:51:21.021414Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ce8ad90e35537ee3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.11:2379]}","request-path":"/0/members/ce8ad90e35537ee3/attributes","cluster-id":"3c17b62c6529d987","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T15:51:21.021427Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T15:51:21.021608Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T15:51:21.021764Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T15:51:21.021856Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T15:51:21.022113Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:51:21.022367Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:51:21.022426Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:51:21.025514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.11:2379"} {"level":"info","ts":"2026-05-26T15:51:21.02559Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T15:51:38.999096Z","caller":"traceutil/trace.go:171","msg":"trace[135579867] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"267.377116ms","start":"2026-05-26T15:51:38.731697Z","end":"2026-05-26T15:51:38.999074Z","steps":["trace[135579867] 'read index received' (duration: 267.164835ms)","trace[135579867] 'applied index is now lower than readState.Index' (duration: 211.531µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:38.999202Z","caller":"traceutil/trace.go:171","msg":"trace[60468543] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"301.142062ms","start":"2026-05-26T15:51:38.698035Z","end":"2026-05-26T15:51:38.999177Z","steps":["trace[60468543] 'process raft request' (duration: 300.89611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:38.999304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.557029ms","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-05-26T15:51:38.99939Z","caller":"traceutil/trace.go:171","msg":"trace[951775902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:376; }","duration":"267.70628ms","start":"2026-05-26T15:51:38.731652Z","end":"2026-05-26T15:51:38.999359Z","steps":["trace[951775902] 'agreement among raft nodes before linearized reading' (duration: 267.542218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:38.999759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:38.698016Z","time spent":"301.276543ms","remote":"127.0.0.1:49082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:51:49.273628Z","caller":"traceutil/trace.go:171","msg":"trace[473084112] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"153.201004ms","start":"2026-05-26T15:51:49.120395Z","end":"2026-05-26T15:51:49.273596Z","steps":["trace[473084112] 'process raft request' (duration: 152.999151ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:54.576626Z","caller":"traceutil/trace.go:171","msg":"trace[999702647] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:460; }","duration":"132.67243ms","start":"2026-05-26T15:51:54.443931Z","end":"2026-05-26T15:51:54.576603Z","steps":["trace[999702647] 'read index received' (duration: 132.528557ms)","trace[999702647] 'applied index is now lower than readState.Index' (duration: 142.853µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:54.57674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.790822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:54.576783Z","caller":"traceutil/trace.go:171","msg":"trace[1356208906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"132.832573ms","start":"2026-05-26T15:51:54.443927Z","end":"2026-05-26T15:51:54.576759Z","steps":["trace[1356208906] 'agreement among raft nodes before linearized reading' (duration: 132.765552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:59.702174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.151421ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T15:52:00.65715Z","caller":"traceutil/trace.go:171","msg":"trace[87768232] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"309.009298ms","start":"2026-05-26T15:52:00.348109Z","end":"2026-05-26T15:52:00.657118Z","steps":["trace[87768232] 'read index received' (duration: 308.749132ms)","trace[87768232] 'applied index is now lower than readState.Index' (duration: 258.766µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:00.657204Z","caller":"traceutil/trace.go:171","msg":"trace[1560154783] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"536.494742ms","start":"2026-05-26T15:52:00.12068Z","end":"2026-05-26T15:52:00.657175Z","steps":["trace[1560154783] 'process raft request' (duration: 536.138654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:00.657351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.225414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:00.657411Z","caller":"traceutil/trace.go:171","msg":"trace[1677883871] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:492; }","duration":"309.337126ms","start":"2026-05-26T15:52:00.348056Z","end":"2026-05-26T15:52:00.657393Z","steps":["trace[1677883871] 'agreement among raft nodes before linearized reading' (duration: 309.227984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:00.657406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:00.120664Z","time spent":"536.624115ms","remote":"127.0.0.1:49182","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-05-26T15:52:00.657468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:00.348034Z","time spent":"309.419639ms","remote":"127.0.0.1:49004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-26T15:52:00.657436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.619772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:00.657539Z","caller":"traceutil/trace.go:171","msg":"trace[2092881583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"211.756585ms","start":"2026-05-26T15:52:00.445765Z","end":"2026-05-26T15:52:00.657522Z","steps":["trace[2092881583] 'agreement among raft nodes before linearized reading' (duration: 211.618611ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:01.795187Z","caller":"traceutil/trace.go:171","msg":"trace[1256411146] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"612.137988ms","start":"2026-05-26T15:52:01.183015Z","end":"2026-05-26T15:52:01.795153Z","steps":["trace[1256411146] 'process raft request' (duration: 603.938801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.795402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.182996Z","time spent":"612.311902ms","remote":"127.0.0.1:48960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:01.796432Z","caller":"traceutil/trace.go:171","msg":"trace[1787514994] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:555; }","duration":"467.919853ms","start":"2026-05-26T15:52:01.328497Z","end":"2026-05-26T15:52:01.796417Z","steps":["trace[1787514994] 'read index received' (duration: 458.571757ms)","trace[1787514994] 'applied index is now lower than readState.Index' (duration: 9.347606ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:01.796588Z","caller":"traceutil/trace.go:171","msg":"trace[1855170186] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"608.920676ms","start":"2026-05-26T15:52:01.18766Z","end":"2026-05-26T15:52:01.796581Z","steps":["trace[1855170186] 'process raft request' (duration: 608.601047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.796659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.187625Z","time spent":"608.981868ms","remote":"127.0.0.1:48960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:01.796753Z","caller":"traceutil/trace.go:171","msg":"trace[195558671] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"554.202384ms","start":"2026-05-26T15:52:01.242546Z","end":"2026-05-26T15:52:01.796748Z","steps":["trace[195558671] 'process raft request' (duration: 553.778393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.796778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.242526Z","time spent":"554.240945ms","remote":"127.0.0.1:48960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T15:52:01.79682Z","caller":"traceutil/trace.go:171","msg":"trace[1534383480] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"534.786223ms","start":"2026-05-26T15:52:01.262029Z","end":"2026-05-26T15:52:01.796816Z","steps":["trace[1534383480] 'process raft request' (duration: 534.330261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.796844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.262001Z","time spent":"534.830254ms","remote":"127.0.0.1:48960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:52:01.796902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.416066ms","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-05-26T15:52:01.796939Z","caller":"traceutil/trace.go:171","msg":"trace[139170723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"468.471507ms","start":"2026-05-26T15:52:01.328463Z","end":"2026-05-26T15:52:01.796935Z","steps":["trace[139170723] 'agreement among raft nodes before linearized reading' (duration: 468.416995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.796952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.328447Z","time spent":"468.502558ms","remote":"127.0.0.1:49182","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-05-26T15:52:01.797031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.361213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:01.797046Z","caller":"traceutil/trace.go:171","msg":"trace[1040030626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"350.392183ms","start":"2026-05-26T15:52:01.446649Z","end":"2026-05-26T15:52:01.797041Z","steps":["trace[1040030626] 'agreement among raft nodes before linearized reading' (duration: 350.369513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.797057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.446636Z","time spent":"350.417934ms","remote":"127.0.0.1:48892","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-05-26T15:52:01.797129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.824852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T15:52:01.797141Z","caller":"traceutil/trace.go:171","msg":"trace[1154466505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"344.837013ms","start":"2026-05-26T15:52:01.4523Z","end":"2026-05-26T15:52:01.797138Z","steps":["trace[1154466505] 'agreement among raft nodes before linearized reading' (duration: 344.811123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.797152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.452259Z","time spent":"344.890986ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:52:01.79725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.80735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T15:52:01.797361Z","caller":"traceutil/trace.go:171","msg":"trace[33982018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"330.977363ms","start":"2026-05-26T15:52:01.46636Z","end":"2026-05-26T15:52:01.797337Z","steps":["trace[33982018] 'agreement among raft nodes before linearized reading' (duration: 330.725336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:01.797414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:01.466339Z","time spent":"331.062436ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:52:07.732735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.526453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:07.732876Z","caller":"traceutil/trace.go:171","msg":"trace[2004298930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"290.733689ms","start":"2026-05-26T15:52:07.44212Z","end":"2026-05-26T15:52:07.732853Z","steps":["trace[2004298930] 'range keys from in-memory index tree' (duration: 290.244074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.34293Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143325825049537281,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T15:52:08.594364Z","caller":"traceutil/trace.go:171","msg":"trace[2029355616] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"754.574287ms","start":"2026-05-26T15:52:07.839766Z","end":"2026-05-26T15:52:08.59434Z","steps":["trace[2029355616] 'read index received' (duration: 752.189208ms)","trace[2029355616] 'applied index is now lower than readState.Index' (duration: 2.383889ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:08.594691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.902296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T15:52:08.594728Z","caller":"traceutil/trace.go:171","msg":"trace[2122533665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"754.996059ms","start":"2026-05-26T15:52:07.839721Z","end":"2026-05-26T15:52:08.594718Z","steps":["trace[2122533665] 'agreement among raft nodes before linearized reading' (duration: 754.757622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.594755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:07.839672Z","time spent":"755.076421ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:52:08.594962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.469604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-26T15:52:08.595005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.751809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T15:52:08.595043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.277952ms","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-05-26T15:52:08.595127Z","caller":"traceutil/trace.go:171","msg":"trace[781986856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"752.372666ms","start":"2026-05-26T15:52:07.842737Z","end":"2026-05-26T15:52:08.59511Z","steps":["trace[781986856] 'agreement among raft nodes before linearized reading' (duration: 752.022945ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:08.595133Z","caller":"traceutil/trace.go:171","msg":"trace[1940168952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"151.905695ms","start":"2026-05-26T15:52:08.443193Z","end":"2026-05-26T15:52:08.595099Z","steps":["trace[1940168952] 'agreement among raft nodes before linearized reading' (duration: 151.686878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.595086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.397654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4qk7k\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-26T15:52:08.595139Z","caller":"traceutil/trace.go:171","msg":"trace[59509273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"754.676251ms","start":"2026-05-26T15:52:07.840405Z","end":"2026-05-26T15:52:08.595082Z","steps":["trace[59509273] 'agreement among raft nodes before linearized reading' (duration: 754.208307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.595175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:07.842586Z","time spent":"752.578911ms","remote":"127.0.0.1:49182","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-05-26T15:52:08.595243Z","caller":"traceutil/trace.go:171","msg":"trace[465598064] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4qk7k; range_end:; response_count:1; response_revision:598; }","duration":"340.592821ms","start":"2026-05-26T15:52:08.25463Z","end":"2026-05-26T15:52:08.595222Z","steps":["trace[465598064] 'agreement among raft nodes before linearized reading' (duration: 339.995043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.595239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:07.840397Z","time spent":"754.817615ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:52:08.595329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.254611Z","time spent":"340.703353ms","remote":"127.0.0.1:49082","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-4qk7k\" "} {"level":"info","ts":"2026-05-26T15:52:08.594528Z","caller":"traceutil/trace.go:171","msg":"trace[87166212] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"788.745117ms","start":"2026-05-26T15:52:07.805739Z","end":"2026-05-26T15:52:08.594484Z","steps":["trace[87166212] 'process raft request' (duration: 788.000505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:08.595783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:07.805692Z","time spent":"789.999683ms","remote":"127.0.0.1:49004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:52:09.203779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143325825049537284,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:52:09.273547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.513685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:52:09.273632Z","caller":"traceutil/trace.go:171","msg":"trace[966411096] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"673.258471ms","start":"2026-05-26T15:52:08.60036Z","end":"2026-05-26T15:52:09.273618Z","steps":["trace[966411096] 'process raft request' (duration: 66.616212ms)","trace[966411096] 'compare' (duration: 606.278568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:09.273674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.600328Z","time spent":"673.327213ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:52:09.704503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143325825049537284,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:52:10.205343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143325825049537284,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:52:10.39719Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.730054339s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-26T15:52:11.390489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.907905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:52:11.390965Z","caller":"traceutil/trace.go:171","msg":"trace[1929423234] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"2.790079872s","start":"2026-05-26T15:52:08.600863Z","end":"2026-05-26T15:52:11.390943Z","steps":["trace[1929423234] 'process raft request' (duration: 2.789713241s)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:11.391001Z","caller":"traceutil/trace.go:171","msg":"trace[1447335619] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"2.790536406s","start":"2026-05-26T15:52:08.600438Z","end":"2026-05-26T15:52:11.390974Z","steps":["trace[1447335619] 'process raft request' (duration: 1.797026552s)","trace[1447335619] 'compare' (duration: 992.564415ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:11.391035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.600854Z","time spent":"2.790151854s","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:11.391015Z","caller":"traceutil/trace.go:171","msg":"trace[1030616396] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"2.777385236s","start":"2026-05-26T15:52:08.6136Z","end":"2026-05-26T15:52:11.390985Z","steps":["trace[1030616396] 'process raft request' (duration: 2.777042606s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:11.391093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.600413Z","time spent":"2.790633999s","remote":"127.0.0.1:49182","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-05-26T15:52:11.39123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.613578Z","time spent":"2.777564142s","remote":"127.0.0.1:49082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:11.391241Z","caller":"traceutil/trace.go:171","msg":"trace[339743098] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"2.726108406s","start":"2026-05-26T15:52:08.665063Z","end":"2026-05-26T15:52:11.391171Z","steps":["trace[339743098] 'process raft request' (duration: 2.725625452s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:11.391559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.665029Z","time spent":"2.726381515s","remote":"127.0.0.1:49282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T15:52:11.397222Z","caller":"traceutil/trace.go:171","msg":"trace[1698970815] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:622; }","duration":"2.693766992s","start":"2026-05-26T15:52:08.703442Z","end":"2026-05-26T15:52:11.397209Z","steps":["trace[1698970815] 'read index received' (duration: 1.69406689s)","trace[1698970815] 'applied index is now lower than readState.Index' (duration: 999.699112ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:11.397436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.952492066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:11.397474Z","caller":"traceutil/trace.go:171","msg":"trace[791547323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.952600569s","start":"2026-05-26T15:52:09.444864Z","end":"2026-05-26T15:52:11.397464Z","steps":["trace[791547323] 'agreement among raft nodes before linearized reading' (duration: 1.952520387s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:11.39753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.005194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-26T15:52:11.397551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:09.444842Z","time spent":"1.952696842s","remote":"127.0.0.1:48892","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-05-26T15:52:11.397556Z","caller":"traceutil/trace.go:171","msg":"trace[1136266243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"120.073515ms","start":"2026-05-26T15:52:11.277474Z","end":"2026-05-26T15:52:11.397548Z","steps":["trace[1136266243] 'agreement among raft nodes before linearized reading' (duration: 119.977303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:11.397826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.694363121s","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-05-26T15:52:11.397936Z","caller":"traceutil/trace.go:171","msg":"trace[1359002532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"2.694507824s","start":"2026-05-26T15:52:08.703406Z","end":"2026-05-26T15:52:11.397914Z","steps":["trace[1359002532] 'agreement among raft nodes before linearized reading' (duration: 2.694009039s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:11.398052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:08.703389Z","time spent":"2.694647269s","remote":"127.0.0.1:49182","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-05-26T15:52:12.741294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.061083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:12.741382Z","caller":"traceutil/trace.go:171","msg":"trace[2139860815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"297.194018ms","start":"2026-05-26T15:52:12.444169Z","end":"2026-05-26T15:52:12.741363Z","steps":["trace[2139860815] 'range keys from in-memory index tree' (duration: 296.985121ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:12.744941Z","caller":"traceutil/trace.go:171","msg":"trace[2100986840] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"298.9092ms","start":"2026-05-26T15:52:12.445986Z","end":"2026-05-26T15:52:12.744896Z","steps":["trace[2100986840] 'process raft request' (duration: 298.348812ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:13.553613Z","caller":"traceutil/trace.go:171","msg":"trace[1201051042] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"107.787632ms","start":"2026-05-26T15:52:13.445799Z","end":"2026-05-26T15:52:13.553587Z","steps":["trace[1201051042] 'read index received' (duration: 106.1028ms)","trace[1201051042] 'applied index is now lower than readState.Index' (duration: 1.683012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:13.553744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.927347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:13.553934Z","caller":"traceutil/trace.go:171","msg":"trace[7714712] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"122.280056ms","start":"2026-05-26T15:52:13.431619Z","end":"2026-05-26T15:52:13.553899Z","steps":["trace[7714712] 'process raft request' (duration: 121.78925ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:13.553777Z","caller":"traceutil/trace.go:171","msg":"trace[394851901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"108.044501ms","start":"2026-05-26T15:52:13.445722Z","end":"2026-05-26T15:52:13.553766Z","steps":["trace[394851901] 'agreement among raft nodes before linearized reading' (duration: 107.964498ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:14.361979Z","caller":"traceutil/trace.go:171","msg":"trace[1533746209] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"118.301943ms","start":"2026-05-26T15:52:14.243648Z","end":"2026-05-26T15:52:14.36195Z","steps":["trace[1533746209] 'process raft request' (duration: 117.969912ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:14.512752Z","caller":"traceutil/trace.go:171","msg":"trace[1483928727] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"102.093181ms","start":"2026-05-26T15:52:14.410642Z","end":"2026-05-26T15:52:14.512735Z","steps":["trace[1483928727] 'process raft request' (duration: 101.952827ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:14.711566Z","caller":"traceutil/trace.go:171","msg":"trace[1897809386] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"144.863314ms","start":"2026-05-26T15:52:14.56668Z","end":"2026-05-26T15:52:14.711544Z","steps":["trace[1897809386] 'read index received' (duration: 144.784431ms)","trace[1897809386] 'applied index is now lower than readState.Index' (duration: 77.843µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:14.711733Z","caller":"traceutil/trace.go:171","msg":"trace[979432127] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"188.303379ms","start":"2026-05-26T15:52:14.523373Z","end":"2026-05-26T15:52:14.711676Z","steps":["trace[979432127] 'process raft request' (duration: 188.050741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:14.711857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.139842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-26T15:52:14.711948Z","caller":"traceutil/trace.go:171","msg":"trace[800234140] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:661; }","duration":"145.294228ms","start":"2026-05-26T15:52:14.566641Z","end":"2026-05-26T15:52:14.711935Z","steps":["trace[800234140] 'agreement among raft nodes before linearized reading' (duration: 144.992167ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:14.726605Z","caller":"traceutil/trace.go:171","msg":"trace[1352158698] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"116.404204ms","start":"2026-05-26T15:52:14.610181Z","end":"2026-05-26T15:52:14.726585Z","steps":["trace[1352158698] 'process raft request' (duration: 116.30038ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:17.057938Z","caller":"traceutil/trace.go:171","msg":"trace[1265453590] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:709; }","duration":"249.95201ms","start":"2026-05-26T15:52:16.807957Z","end":"2026-05-26T15:52:17.057909Z","steps":["trace[1265453590] 'read index received' (duration: 249.496074ms)","trace[1265453590] 'applied index is now lower than readState.Index' (duration: 454.846µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:17.058026Z","caller":"traceutil/trace.go:171","msg":"trace[14248291] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"332.607226ms","start":"2026-05-26T15:52:16.725384Z","end":"2026-05-26T15:52:17.057991Z","steps":["trace[14248291] 'process raft request' (duration: 332.207613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:17.058199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.205738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"warn","ts":"2026-05-26T15:52:17.058211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:16.725353Z","time spent":"332.755531ms","remote":"127.0.0.1:48960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:17.05824Z","caller":"traceutil/trace.go:171","msg":"trace[1909121715] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:685; }","duration":"250.30221ms","start":"2026-05-26T15:52:16.807926Z","end":"2026-05-26T15:52:17.058228Z","steps":["trace[1909121715] 'agreement among raft nodes before linearized reading' (duration: 250.100633ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:17.232261Z","caller":"traceutil/trace.go:171","msg":"trace[408604652] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"171.876661ms","start":"2026-05-26T15:52:17.060361Z","end":"2026-05-26T15:52:17.232238Z","steps":["trace[408604652] 'process raft request' (duration: 111.374798ms)","trace[408604652] 'compare' (duration: 60.355478ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:25.620347Z","caller":"traceutil/trace.go:171","msg":"trace[381021990] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"263.207093ms","start":"2026-05-26T15:52:25.357117Z","end":"2026-05-26T15:52:25.620324Z","steps":["trace[381021990] 'read index received' (duration: 262.985035ms)","trace[381021990] 'applied index is now lower than readState.Index' (duration: 221.258µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:25.620578Z","caller":"traceutil/trace.go:171","msg":"trace[719860071] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"314.077589ms","start":"2026-05-26T15:52:25.306483Z","end":"2026-05-26T15:52:25.620561Z","steps":["trace[719860071] 'process raft request' (duration: 313.693786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:25.620728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:25.306447Z","time spent":"314.200243ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:52:25.621051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.909628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-vh2tk\" ","response":"range_response_count:1 size:5049"} {"level":"info","ts":"2026-05-26T15:52:25.621136Z","caller":"traceutil/trace.go:171","msg":"trace[1109109498] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-vh2tk; range_end:; response_count:1; response_revision:750; }","duration":"264.034023ms","start":"2026-05-26T15:52:25.357084Z","end":"2026-05-26T15:52:25.621118Z","steps":["trace[1109109498] 'agreement among raft nodes before linearized reading' (duration: 263.766313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:25.621566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.819948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:25.621691Z","caller":"traceutil/trace.go:171","msg":"trace[1723112535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"175.990904ms","start":"2026-05-26T15:52:25.445669Z","end":"2026-05-26T15:52:25.62166Z","steps":["trace[1723112535] 'agreement among raft nodes before linearized reading' (duration: 175.801237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:25.621711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.905275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T15:52:25.621753Z","caller":"traceutil/trace.go:171","msg":"trace[355521194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"102.998188ms","start":"2026-05-26T15:52:25.518745Z","end":"2026-05-26T15:52:25.621743Z","steps":["trace[355521194] 'agreement among raft nodes before linearized reading' (duration: 102.783801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:25.622351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.463898ms","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-05-26T15:52:25.62244Z","caller":"traceutil/trace.go:171","msg":"trace[223226435] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:750; }","duration":"110.586183ms","start":"2026-05-26T15:52:25.511835Z","end":"2026-05-26T15:52:25.622421Z","steps":["trace[223226435] 'agreement among raft nodes before linearized reading' (duration: 110.414887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:25.622588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.151051ms","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-05-26T15:52:25.622639Z","caller":"traceutil/trace.go:171","msg":"trace[1559542501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:750; }","duration":"109.225623ms","start":"2026-05-26T15:52:25.513405Z","end":"2026-05-26T15:52:25.622631Z","steps":["trace[1559542501] 'agreement among raft nodes before linearized reading' (duration: 109.115889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:28.944028Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143325825049537624,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T15:52:29.125046Z","caller":"traceutil/trace.go:171","msg":"trace[1093939940] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"681.799511ms","start":"2026-05-26T15:52:28.443228Z","end":"2026-05-26T15:52:29.125027Z","steps":["trace[1093939940] 'read index received' (duration: 681.590084ms)","trace[1093939940] 'applied index is now lower than readState.Index' (duration: 208.857µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:29.125127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.894835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:29.125143Z","caller":"traceutil/trace.go:171","msg":"trace[1170608705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"681.953647ms","start":"2026-05-26T15:52:28.443184Z","end":"2026-05-26T15:52:29.125138Z","steps":["trace[1170608705] 'agreement among raft nodes before linearized reading' (duration: 681.912136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:29.125165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:28.443167Z","time spent":"681.991218ms","remote":"127.0.0.1:48892","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-05-26T15:52:29.125167Z","caller":"traceutil/trace.go:171","msg":"trace[1397393608] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"742.070022ms","start":"2026-05-26T15:52:28.383048Z","end":"2026-05-26T15:52:29.125118Z","steps":["trace[1397393608] 'process raft request' (duration: 741.850235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:29.125417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:28.383027Z","time spent":"742.189887ms","remote":"127.0.0.1:49160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:43.046768Z","caller":"traceutil/trace.go:171","msg":"trace[462058140] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:963; }","duration":"179.440975ms","start":"2026-05-26T15:52:42.867304Z","end":"2026-05-26T15:52:43.046745Z","steps":["trace[462058140] 'read index received' (duration: 179.265388ms)","trace[462058140] 'applied index is now lower than readState.Index' (duration: 174.577µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:43.046905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.57803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:52:43.046896Z","caller":"traceutil/trace.go:171","msg":"trace[1834207542] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"205.363654ms","start":"2026-05-26T15:52:42.841497Z","end":"2026-05-26T15:52:43.046861Z","steps":["trace[1834207542] 'process raft request' (duration: 205.089833ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:43.046957Z","caller":"traceutil/trace.go:171","msg":"trace[938788138] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:932; }","duration":"179.681564ms","start":"2026-05-26T15:52:42.867264Z","end":"2026-05-26T15:52:43.046945Z","steps":["trace[938788138] 'agreement among raft nodes before linearized reading' (duration: 179.58606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:43.254318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.165772ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:52:43.254493Z","caller":"traceutil/trace.go:171","msg":"trace[519817327] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"200.411174ms","start":"2026-05-26T15:52:43.054056Z","end":"2026-05-26T15:52:43.254467Z","steps":["trace[519817327] 'process raft request' (duration: 72.96342ms)","trace[519817327] 'compare' (duration: 126.964263ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:52:43.277401Z","caller":"traceutil/trace.go:171","msg":"trace[101480488] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"219.053624ms","start":"2026-05-26T15:52:43.058326Z","end":"2026-05-26T15:52:43.27738Z","steps":["trace[101480488] 'process raft request' (duration: 218.993371ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:43.277481Z","caller":"traceutil/trace.go:171","msg":"trace[198685462] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"223.002491ms","start":"2026-05-26T15:52:43.054431Z","end":"2026-05-26T15:52:43.277433Z","steps":["trace[198685462] 'process raft request' (duration: 222.75221ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:44.62831Z","caller":"traceutil/trace.go:171","msg":"trace[1618664139] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"121.491758ms","start":"2026-05-26T15:52:44.506789Z","end":"2026-05-26T15:52:44.62828Z","steps":["trace[1618664139] 'process raft request' (duration: 121.29092ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:57.893902Z","caller":"traceutil/trace.go:171","msg":"trace[814414414] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"206.508644ms","start":"2026-05-26T15:52:57.687363Z","end":"2026-05-26T15:52:57.893871Z","steps":["trace[814414414] 'process raft request' (duration: 206.271364ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:57.95253Z","caller":"traceutil/trace.go:171","msg":"trace[356125415] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"252.198041ms","start":"2026-05-26T15:52:57.700302Z","end":"2026-05-26T15:52:57.952501Z","steps":["trace[356125415] 'process raft request' (duration: 251.986261ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:58.115525Z","caller":"traceutil/trace.go:171","msg":"trace[961685879] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"176.920905ms","start":"2026-05-26T15:52:57.938571Z","end":"2026-05-26T15:52:58.115492Z","steps":["trace[961685879] 'process raft request' (duration: 135.088225ms)","trace[961685879] 'compare' (duration: 41.508055ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:58.115931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.894768ms","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-05-26T15:52:58.115958Z","caller":"traceutil/trace.go:171","msg":"trace[1681278315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:998; }","duration":"230.95583ms","start":"2026-05-26T15:52:57.884993Z","end":"2026-05-26T15:52:58.115949Z","steps":["trace[1681278315] 'agreement among raft nodes before linearized reading' (duration: 230.808914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:58.115987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.488558ms","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-05-26T15:52:58.116279Z","caller":"traceutil/trace.go:171","msg":"trace[1174438723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:998; }","duration":"228.864276ms","start":"2026-05-26T15:52:57.887398Z","end":"2026-05-26T15:52:58.116262Z","steps":["trace[1174438723] 'agreement among raft nodes before linearized reading' (duration: 228.244978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:58.116316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.90429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T15:52:58.116385Z","caller":"traceutil/trace.go:171","msg":"trace[984433345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:998; }","duration":"233.010124ms","start":"2026-05-26T15:52:57.883358Z","end":"2026-05-26T15:52:58.116368Z","steps":["trace[984433345] 'agreement among raft nodes before linearized reading' (duration: 232.613365ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:58.115943Z","caller":"traceutil/trace.go:171","msg":"trace[261557847] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1031; }","duration":"163.132949ms","start":"2026-05-26T15:52:57.952487Z","end":"2026-05-26T15:52:58.11562Z","steps":["trace[261557847] 'read index received' (duration: 121.145991ms)","trace[261557847] 'applied index is now lower than readState.Index' (duration: 41.983948ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:52:58.116902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.223183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T15:52:58.117044Z","caller":"traceutil/trace.go:171","msg":"trace[1732264716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:998; }","duration":"231.380631ms","start":"2026-05-26T15:52:57.885638Z","end":"2026-05-26T15:52:58.117018Z","steps":["trace[1732264716] 'agreement among raft nodes before linearized reading' (duration: 229.988117ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:58.117012Z","caller":"traceutil/trace.go:171","msg":"trace[1695044613] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"158.876555ms","start":"2026-05-26T15:52:57.958089Z","end":"2026-05-26T15:52:58.116966Z","steps":["trace[1695044613] 'process raft request' (duration: 157.400168ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:58.488645Z","caller":"traceutil/trace.go:171","msg":"trace[601979829] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"366.99824ms","start":"2026-05-26T15:52:58.121619Z","end":"2026-05-26T15:52:58.488617Z","steps":["trace[601979829] 'process raft request' (duration: 366.684285ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:52:58.488672Z","caller":"traceutil/trace.go:171","msg":"trace[1065641233] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"366.498977ms","start":"2026-05-26T15:52:58.122142Z","end":"2026-05-26T15:52:58.488641Z","steps":["trace[1065641233] 'process raft request' (duration: 366.387261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:58.488785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:58.12158Z","time spent":"367.141877ms","remote":"127.0.0.1:49182","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-05-26T15:52:58.488869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:58.122129Z","time spent":"366.632344ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:52:58.489007Z","caller":"traceutil/trace.go:171","msg":"trace[1737245086] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"366.261066ms","start":"2026-05-26T15:52:58.122699Z","end":"2026-05-26T15:52:58.48896Z","steps":["trace[1737245086] 'process raft request' (duration: 365.896569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:52:58.489419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:52:58.122689Z","time spent":"366.604591ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:53:22.251515Z","caller":"traceutil/trace.go:171","msg":"trace[1048319001] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"118.932577ms","start":"2026-05-26T15:53:22.132542Z","end":"2026-05-26T15:53:22.251475Z","steps":["trace[1048319001] 'process raft request' (duration: 118.755839ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:53:24.453521Z","caller":"traceutil/trace.go:171","msg":"trace[978100887] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"194.991194ms","start":"2026-05-26T15:53:24.258509Z","end":"2026-05-26T15:53:24.4535Z","steps":["trace[978100887] 'process raft request' (duration: 194.627396ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:53:24.574108Z","caller":"traceutil/trace.go:171","msg":"trace[1610200217] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"118.030227ms","start":"2026-05-26T15:53:24.456049Z","end":"2026-05-26T15:53:24.574079Z","steps":["trace[1610200217] 'read index received' (duration: 117.319971ms)","trace[1610200217] 'applied index is now lower than readState.Index' (duration: 708.406µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:53:24.574278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.197465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:53:24.574311Z","caller":"traceutil/trace.go:171","msg":"trace[2092962792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1085; }","duration":"118.275149ms","start":"2026-05-26T15:53:24.456025Z","end":"2026-05-26T15:53:24.574301Z","steps":["trace[2092962792] 'agreement among raft nodes before linearized reading' (duration: 118.183724ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:53:24.574649Z","caller":"traceutil/trace.go:171","msg":"trace[693673182] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"117.240726ms","start":"2026-05-26T15:53:24.457372Z","end":"2026-05-26T15:53:24.574613Z","steps":["trace[693673182] 'process raft request' (duration: 116.935461ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:53:26.854559Z","caller":"traceutil/trace.go:171","msg":"trace[2052856080] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"140.459857ms","start":"2026-05-26T15:53:26.714075Z","end":"2026-05-26T15:53:26.854535Z","steps":["trace[2052856080] 'process raft request' (duration: 140.30425ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:35.177168Z","caller":"traceutil/trace.go:171","msg":"trace[1900055089] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1411; }","duration":"196.847011ms","start":"2026-05-26T15:54:34.980297Z","end":"2026-05-26T15:54:35.177144Z","steps":["trace[1900055089] 'read index received' (duration: 196.648319ms)","trace[1900055089] 'applied index is now lower than readState.Index' (duration: 197.822µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:54:35.177259Z","caller":"traceutil/trace.go:171","msg":"trace[1287293616] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"263.078611ms","start":"2026-05-26T15:54:34.914141Z","end":"2026-05-26T15:54:35.17722Z","steps":["trace[1287293616] 'process raft request' (duration: 262.854658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:35.177878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.542261ms","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-05-26T15:54:35.178417Z","caller":"traceutil/trace.go:171","msg":"trace[1105524204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1356; }","duration":"198.135355ms","start":"2026-05-26T15:54:34.980233Z","end":"2026-05-26T15:54:35.178368Z","steps":["trace[1105524204] 'agreement among raft nodes before linearized reading' (duration: 197.16202ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:35.398615Z","caller":"traceutil/trace.go:171","msg":"trace[2105664630] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"216.035ms","start":"2026-05-26T15:54:35.182562Z","end":"2026-05-26T15:54:35.398597Z","steps":["trace[2105664630] 'process raft request' (duration: 215.922964ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:35.400788Z","caller":"traceutil/trace.go:171","msg":"trace[1139603533] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1412; }","duration":"154.207426ms","start":"2026-05-26T15:54:35.246557Z","end":"2026-05-26T15:54:35.400765Z","steps":["trace[1139603533] 'read index received' (duration: 152.015672ms)","trace[1139603533] 'applied index is now lower than readState.Index' (duration: 2.190564ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:54:35.400811Z","caller":"traceutil/trace.go:171","msg":"trace[689209349] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"218.16938ms","start":"2026-05-26T15:54:35.182624Z","end":"2026-05-26T15:54:35.400793Z","steps":["trace[689209349] 'process raft request' (duration: 218.057833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:35.400939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.332623ms","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-05-26T15:54:35.401014Z","caller":"traceutil/trace.go:171","msg":"trace[1630034313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1360; }","duration":"154.478081ms","start":"2026-05-26T15:54:35.246516Z","end":"2026-05-26T15:54:35.400994Z","steps":["trace[1630034313] 'agreement among raft nodes before linearized reading' (duration: 154.326752ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:35.400835Z","caller":"traceutil/trace.go:171","msg":"trace[2137536674] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"217.799869ms","start":"2026-05-26T15:54:35.18302Z","end":"2026-05-26T15:54:35.40082Z","steps":["trace[2137536674] 'process raft request' (duration: 217.695313ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:35.401227Z","caller":"traceutil/trace.go:171","msg":"trace[960736355] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"218.649019ms","start":"2026-05-26T15:54:35.182562Z","end":"2026-05-26T15:54:35.401211Z","steps":["trace[960736355] 'process raft request' (duration: 218.008862ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:57.625212Z","caller":"traceutil/trace.go:171","msg":"trace[588626889] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"125.78698ms","start":"2026-05-26T15:54:57.499402Z","end":"2026-05-26T15:54:57.625189Z","steps":["trace[588626889] 'process raft request' (duration: 125.640381ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:57.62527Z","caller":"traceutil/trace.go:171","msg":"trace[153159160] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1494; }","duration":"108.776459ms","start":"2026-05-26T15:54:57.516441Z","end":"2026-05-26T15:54:57.625217Z","steps":["trace[153159160] 'read index received' (duration: 108.750978ms)","trace[153159160] 'applied index is now lower than readState.Index' (duration: 21.491µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:54:57.625506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.025353ms","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-05-26T15:54:57.625626Z","caller":"traceutil/trace.go:171","msg":"trace[1761280131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1434; }","duration":"109.192784ms","start":"2026-05-26T15:54:57.516404Z","end":"2026-05-26T15:54:57.625597Z","steps":["trace[1761280131] 'agreement among raft nodes before linearized reading' (duration: 108.889115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:57.625738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.07874ms","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-05-26T15:54:57.625803Z","caller":"traceutil/trace.go:171","msg":"trace[2133295715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1434; }","duration":"104.229488ms","start":"2026-05-26T15:54:57.521557Z","end":"2026-05-26T15:54:57.625786Z","steps":["trace[2133295715] 'agreement among raft nodes before linearized reading' (duration: 103.934821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:57.625742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.272308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T15:54:57.625889Z","caller":"traceutil/trace.go:171","msg":"trace[1447115814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1434; }","duration":"109.432387ms","start":"2026-05-26T15:54:57.516429Z","end":"2026-05-26T15:54:57.625862Z","steps":["trace[1447115814] 'agreement among raft nodes before linearized reading' (duration: 109.011513ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:57.878389Z","caller":"traceutil/trace.go:171","msg":"trace[1539942096] linearizableReadLoop","detail":"{readStateIndex:1495; appliedIndex:1494; }","duration":"247.938309ms","start":"2026-05-26T15:54:57.63042Z","end":"2026-05-26T15:54:57.878358Z","steps":["trace[1539942096] 'read index received' (duration: 208.969257ms)","trace[1539942096] 'applied index is now lower than readState.Index' (duration: 38.968022ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:54:57.878485Z","caller":"traceutil/trace.go:171","msg":"trace[995312313] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"248.13042ms","start":"2026-05-26T15:54:57.630313Z","end":"2026-05-26T15:54:57.878444Z","steps":["trace[995312313] 'process raft request' (duration: 208.985487ms)","trace[995312313] 'compare' (duration: 38.672526ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:54:57.878639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.193113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-05-26T15:54:57.878721Z","caller":"traceutil/trace.go:171","msg":"trace[1841253675] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1435; }","duration":"248.325181ms","start":"2026-05-26T15:54:57.630375Z","end":"2026-05-26T15:54:57.878701Z","steps":["trace[1841253675] 'agreement among raft nodes before linearized reading' (duration: 248.107728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:57.879037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.569359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:54:57.87912Z","caller":"traceutil/trace.go:171","msg":"trace[1086638763] range","detail":"{range_begin:/registry/statefulsets/kube-node-lease/; range_end:/registry/statefulsets/kube-node-lease0; response_count:0; response_revision:1437; }","duration":"120.691146ms","start":"2026-05-26T15:54:57.758407Z","end":"2026-05-26T15:54:57.879099Z","steps":["trace[1086638763] 'agreement among raft nodes before linearized reading' (duration: 120.529826ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:57.879513Z","caller":"traceutil/trace.go:171","msg":"trace[1383652227] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"247.587547ms","start":"2026-05-26T15:54:57.631911Z","end":"2026-05-26T15:54:57.879499Z","steps":["trace[1383652227] 'process raft request' (duration: 246.827374ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:57.879538Z","caller":"traceutil/trace.go:171","msg":"trace[244829541] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"247.285001ms","start":"2026-05-26T15:54:57.632238Z","end":"2026-05-26T15:54:57.879523Z","steps":["trace[244829541] 'process raft request' (duration: 246.632363ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:59.062834Z","caller":"traceutil/trace.go:171","msg":"trace[1279624791] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1497; }","duration":"118.94397ms","start":"2026-05-26T15:54:58.943863Z","end":"2026-05-26T15:54:59.062807Z","steps":["trace[1279624791] 'read index received' (duration: 118.707317ms)","trace[1279624791] 'applied index is now lower than readState.Index' (duration: 235.813µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:54:59.062935Z","caller":"traceutil/trace.go:171","msg":"trace[345097526] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"131.408629ms","start":"2026-05-26T15:54:58.931496Z","end":"2026-05-26T15:54:59.062905Z","steps":["trace[345097526] 'process raft request' (duration: 131.134453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:59.064538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.580209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/local-path-storage/\" range_end:\"/registry/daemonsets/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:54:59.064634Z","caller":"traceutil/trace.go:171","msg":"trace[1431608639] range","detail":"{range_begin:/registry/daemonsets/local-path-storage/; range_end:/registry/daemonsets/local-path-storage0; response_count:0; response_revision:1438; }","duration":"106.743888ms","start":"2026-05-26T15:54:58.957865Z","end":"2026-05-26T15:54:59.064609Z","steps":["trace[1431608639] 'agreement among raft nodes before linearized reading' (duration: 106.543856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:59.063139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.230688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-05-26T15:54:59.065104Z","caller":"traceutil/trace.go:171","msg":"trace[1308835861] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1438; }","duration":"121.210543ms","start":"2026-05-26T15:54:58.943826Z","end":"2026-05-26T15:54:59.065036Z","steps":["trace[1308835861] 'agreement among raft nodes before linearized reading' (duration: 119.188986ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:59.464009Z","caller":"traceutil/trace.go:171","msg":"trace[483675141] linearizableReadLoop","detail":"{readStateIndex:1499; appliedIndex:1498; }","duration":"141.395937ms","start":"2026-05-26T15:54:59.322589Z","end":"2026-05-26T15:54:59.463985Z","steps":["trace[483675141] 'read index received' (duration: 141.152513ms)","trace[483675141] 'applied index is now lower than readState.Index' (duration: 242.494µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:54:59.464485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.838692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:54:59.464632Z","caller":"traceutil/trace.go:171","msg":"trace[1978273685] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1439; }","duration":"142.027023ms","start":"2026-05-26T15:54:59.32258Z","end":"2026-05-26T15:54:59.464607Z","steps":["trace[1978273685] 'agreement among raft nodes before linearized reading' (duration: 141.723196ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:59.464786Z","caller":"traceutil/trace.go:171","msg":"trace[1916750389] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"163.801268ms","start":"2026-05-26T15:54:59.300804Z","end":"2026-05-26T15:54:59.464606Z","steps":["trace[1916750389] 'process raft request' (duration: 163.012102ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:59.745166Z","caller":"traceutil/trace.go:171","msg":"trace[1532549256] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"109.264625ms","start":"2026-05-26T15:54:59.635873Z","end":"2026-05-26T15:54:59.745138Z","steps":["trace[1532549256] 'process raft request' (duration: 108.974779ms)"],"step_count":1}