{"level":"warn","ts":"2026-05-26T08:14:57.806743Z","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-26T08:14:57.806822Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.102: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.102:2380","--initial-cluster=instance=https://199.19.213.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.102: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-26T08:14:57.806885Z","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-26T08:14:57.806897Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.102:2380"]} {"level":"info","ts":"2026-05-26T08:14:57.806914Z","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-26T08:14:57.807593Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"]} {"level":"info","ts":"2026-05-26T08:14:57.807674Z","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.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.102: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-26T08:14:57.815908Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.03334ms"} {"level":"info","ts":"2026-05-26T08:14:57.829039Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1ee87564e61d159f","cluster-id":"92a92aec402e97c3"} {"level":"info","ts":"2026-05-26T08:14:57.829111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T08:14:57.829133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 0"} {"level":"info","ts":"2026-05-26T08:14:57.829146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1ee87564e61d159f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T08:14:57.829247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 1"} {"level":"info","ts":"2026-05-26T08:14:57.82934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"} {"level":"warn","ts":"2026-05-26T08:14:57.868646Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T08:14:57.87431Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T08:14:57.889657Z","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-26T08:14:57.898856Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1ee87564e61d159f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T08:14:57.899239Z","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-26T08:14:57.899481Z","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-26T08:14:57.899672Z","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-26T08:14:57.899367Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1ee87564e61d159f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T08:14:57.905206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"} {"level":"info","ts":"2026-05-26T08:14:57.905335Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","added-peer-id":"1ee87564e61d159f","added-peer-peer-urls":["https://199.19.213.102:2380"]} {"level":"info","ts":"2026-05-26T08:14:57.905485Z","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-26T08:14:57.905648Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.102:2380"} {"level":"info","ts":"2026-05-26T08:14:57.905686Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.102:2380"} {"level":"info","ts":"2026-05-26T08:14:57.906777Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1ee87564e61d159f","initial-advertise-peer-urls":["https://199.19.213.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T08:14:57.90683Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T08:14:58.032545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T08:14:58.032588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T08:14:58.032607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgPreVoteResp from 1ee87564e61d159f at term 1"} {"level":"info","ts":"2026-05-26T08:14:58.032618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became candidate at term 2"} {"level":"info","ts":"2026-05-26T08:14:58.032624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgVoteResp from 1ee87564e61d159f at term 2"} {"level":"info","ts":"2026-05-26T08:14:58.032632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became leader at term 2"} {"level":"info","ts":"2026-05-26T08:14:58.032639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1ee87564e61d159f elected leader 1ee87564e61d159f at term 2"} {"level":"info","ts":"2026-05-26T08:14:58.039029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T08:14:58.04091Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1ee87564e61d159f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.102:2379]}","request-path":"/0/members/1ee87564e61d159f/attributes","cluster-id":"92a92aec402e97c3","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T08:14:58.040966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T08:14:58.041295Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T08:14:58.041361Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T08:14:58.041042Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T08:14:58.043597Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T08:14:58.043744Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T08:14:58.044251Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T08:14:58.044553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.102:2379"} {"level":"info","ts":"2026-05-26T08:14:58.046932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T08:14:59.674301Z","caller":"traceutil/trace.go:171","msg":"trace[205866208] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"174.527099ms","start":"2026-05-26T08:14:59.499751Z","end":"2026-05-26T08:14:59.674278Z","steps":["trace[205866208] 'process raft request' (duration: 174.285965ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:00.414097Z","caller":"traceutil/trace.go:171","msg":"trace[369025516] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"845.346742ms","start":"2026-05-26T08:14:59.56872Z","end":"2026-05-26T08:15:00.414067Z","steps":["trace[369025516] 'process raft request' (duration: 845.23083ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:00.414202Z","caller":"traceutil/trace.go:171","msg":"trace[296868829] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"911.233279ms","start":"2026-05-26T08:14:59.50292Z","end":"2026-05-26T08:15:00.414153Z","steps":["trace[296868829] 'process raft request' (duration: 910.771349ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:00.4142Z","caller":"traceutil/trace.go:171","msg":"trace[1051918820] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"845.070178ms","start":"2026-05-26T08:14:59.569103Z","end":"2026-05-26T08:15:00.414173Z","steps":["trace[1051918820] 'process raft request' (duration: 844.875003ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:00.414385Z","caller":"traceutil/trace.go:171","msg":"trace[1587889183] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"846.022407ms","start":"2026-05-26T08:14:59.568297Z","end":"2026-05-26T08:15:00.414319Z","steps":["trace[1587889183] 'process raft request' (duration: 845.575537ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:00.414542Z","caller":"traceutil/trace.go:171","msg":"trace[384492164] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"845.988595ms","start":"2026-05-26T08:14:59.568508Z","end":"2026-05-26T08:15:00.414496Z","steps":["trace[384492164] 'process raft request' (duration: 845.402573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.414711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.568703Z","time spent":"845.468506ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:00.414702Z","caller":"traceutil/trace.go:171","msg":"trace[740927986] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"844.975036ms","start":"2026-05-26T08:14:59.56961Z","end":"2026-05-26T08:15:00.414585Z","steps":["trace[740927986] 'process raft request' (duration: 844.393404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.414895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.569087Z","time spent":"845.2038ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:00.414968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.5696Z","time spent":"845.280651ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:00.414759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.568501Z","time spent":"846.17936ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:00.416377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.502907Z","time spent":"911.377392ms","remote":"127.0.0.1:38764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:15:00.415079Z","caller":"traceutil/trace.go:171","msg":"trace[1944055437] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"911.592526ms","start":"2026-05-26T08:14:59.503407Z","end":"2026-05-26T08:15:00.415Z","steps":["trace[1944055437] 'read index received' (duration: 170.783285ms)","trace[1944055437] 'applied index is now lower than readState.Index' (duration: 740.808091ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:15:00.41648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.568278Z","time spent":"846.14094ms","remote":"127.0.0.1:39186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:00.419233Z","caller":"traceutil/trace.go:171","msg":"trace[452436469] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"834.772773ms","start":"2026-05-26T08:14:59.584432Z","end":"2026-05-26T08:15:00.419205Z","steps":["trace[452436469] 'process raft request' (duration: 830.511139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.419399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.584414Z","time spent":"834.926586ms","remote":"127.0.0.1:38876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:00.419606Z","caller":"traceutil/trace.go:171","msg":"trace[1164538295] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"849.74764ms","start":"2026-05-26T08:14:59.569819Z","end":"2026-05-26T08:15:00.419567Z","steps":["trace[1164538295] 'process raft request' (duration: 844.930355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.419749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.569782Z","time spent":"849.898213ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:00.420243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.948548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.420343Z","caller":"traceutil/trace.go:171","msg":"trace[788728440] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"774.150232ms","start":"2026-05-26T08:14:59.646174Z","end":"2026-05-26T08:15:00.420324Z","steps":["trace[788728440] 'agreement among raft nodes before linearized reading' (duration: 773.531969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.420376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.646144Z","time spent":"774.224794ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-26T08:15:00.415372Z","caller":"traceutil/trace.go:171","msg":"trace[1418086118] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"831.280733ms","start":"2026-05-26T08:14:59.584066Z","end":"2026-05-26T08:15:00.415347Z","steps":["trace[1418086118] 'process raft request' (duration: 830.787004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.420422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.500274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T08:15:00.420577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.584024Z","time spent":"836.520668ms","remote":"127.0.0.1:38948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:00.420583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.67088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.420741Z","caller":"traceutil/trace.go:171","msg":"trace[1018827489] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"800.911922ms","start":"2026-05-26T08:14:59.619763Z","end":"2026-05-26T08:15:00.420675Z","steps":["trace[1018827489] 'agreement among raft nodes before linearized reading' (duration: 800.163918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.420815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.61974Z","time spent":"801.055945ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-26T08:15:00.420891Z","caller":"traceutil/trace.go:171","msg":"trace[1574046985] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"784.816442ms","start":"2026-05-26T08:14:59.635863Z","end":"2026-05-26T08:15:00.42068Z","steps":["trace[1574046985] 'agreement among raft nodes before linearized reading' (duration: 784.595848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.420837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.440167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.421002Z","caller":"traceutil/trace.go:171","msg":"trace[1860805489] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"774.615281ms","start":"2026-05-26T08:14:59.646376Z","end":"2026-05-26T08:15:00.420991Z","steps":["trace[1860805489] 'agreement among raft nodes before linearized reading' (duration: 774.329306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.421031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.646371Z","time spent":"774.652572ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T08:15:00.421032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.635851Z","time spent":"785.097359ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-26T08:15:00.420963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.990045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.421113Z","caller":"traceutil/trace.go:171","msg":"trace[429796802] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"850.705418ms","start":"2026-05-26T08:14:59.570381Z","end":"2026-05-26T08:15:00.421086Z","steps":["trace[429796802] 'agreement among raft nodes before linearized reading' (duration: 849.991875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.421204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.57037Z","time spent":"850.76999ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-26T08:15:00.421436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.066587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.421488Z","caller":"traceutil/trace.go:171","msg":"trace[282837530] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"852.22255ms","start":"2026-05-26T08:14:59.569251Z","end":"2026-05-26T08:15:00.421474Z","steps":["trace[282837530] 'agreement among raft nodes before linearized reading' (duration: 851.919384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.421722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.56924Z","time spent":"852.305001ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T08:15:00.421693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.256958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-26T08:15:00.426059Z","caller":"traceutil/trace.go:171","msg":"trace[1400023498] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"922.653715ms","start":"2026-05-26T08:14:59.503389Z","end":"2026-05-26T08:15:00.426043Z","steps":["trace[1400023498] 'agreement among raft nodes before linearized reading' (duration: 918.046014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.426111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.503384Z","time spent":"922.705937ms","remote":"127.0.0.1:38876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-26T08:15:00.426215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.060439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.426274Z","caller":"traceutil/trace.go:171","msg":"trace[1836904652] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"780.166501ms","start":"2026-05-26T08:14:59.646099Z","end":"2026-05-26T08:15:00.426265Z","steps":["trace[1836904652] 'agreement among raft nodes before linearized reading' (duration: 773.948778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.426306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.646072Z","time spent":"780.227262ms","remote":"127.0.0.1:38808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T08:15:00.426413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.052024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.102\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T08:15:00.426446Z","caller":"traceutil/trace.go:171","msg":"trace[2060924399] range","detail":"{range_begin:/registry/masterleases/199.19.213.102; range_end:; response_count:0; response_revision:11; }","duration":"859.113975ms","start":"2026-05-26T08:14:59.567326Z","end":"2026-05-26T08:15:00.42644Z","steps":["trace[2060924399] 'agreement among raft nodes before linearized reading' (duration: 851.933073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:00.426518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:14:59.567282Z","time spent":"859.228178ms","remote":"127.0.0.1:38744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.102\" "} {"level":"info","ts":"2026-05-26T08:15:08.565574Z","caller":"traceutil/trace.go:171","msg":"trace[1957221929] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"104.129413ms","start":"2026-05-26T08:15:08.461403Z","end":"2026-05-26T08:15:08.565533Z","steps":["trace[1957221929] 'process raft request' (duration: 47.95972ms)","trace[1957221929] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/pods/kube-system/coredns-7c96b6546b-xzkmn; req_size:3998; } (duration: 55.850457ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:15:25.463902Z","caller":"traceutil/trace.go:171","msg":"trace[790403467] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"623.230372ms","start":"2026-05-26T08:15:24.840648Z","end":"2026-05-26T08:15:25.463878Z","steps":["trace[790403467] 'process raft request' (duration: 623.10594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.464169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.840632Z","time spent":"623.340515ms","remote":"127.0.0.1:38754","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-05-26T08:15:25.523325Z","caller":"traceutil/trace.go:171","msg":"trace[716978615] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"663.593622ms","start":"2026-05-26T08:15:24.859673Z","end":"2026-05-26T08:15:25.523267Z","steps":["trace[716978615] 'process raft request' (duration: 663.332617ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.523379Z","caller":"traceutil/trace.go:171","msg":"trace[836541672] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"663.578201ms","start":"2026-05-26T08:15:24.859764Z","end":"2026-05-26T08:15:25.523342Z","steps":["trace[836541672] 'process raft request' (duration: 663.360417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.523629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.85976Z","time spent":"663.707434ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:25.523655Z","caller":"traceutil/trace.go:171","msg":"trace[1974877385] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"643.718268ms","start":"2026-05-26T08:15:24.879871Z","end":"2026-05-26T08:15:25.523589Z","steps":["trace[1974877385] 'process raft request' (duration: 643.530014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.523709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.859657Z","time spent":"663.760555ms","remote":"127.0.0.1:38754","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-05-26T08:15:25.523713Z","caller":"traceutil/trace.go:171","msg":"trace[1529778012] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"651.234847ms","start":"2026-05-26T08:15:24.872285Z","end":"2026-05-26T08:15:25.523519Z","steps":["trace[1529778012] 'process raft request' (duration: 650.977022ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.523833Z","caller":"traceutil/trace.go:171","msg":"trace[1538031563] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"640.745858ms","start":"2026-05-26T08:15:24.883064Z","end":"2026-05-26T08:15:25.52381Z","steps":["trace[1538031563] 'process raft request' (duration: 640.423262ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.523692Z","caller":"traceutil/trace.go:171","msg":"trace[1312443920] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"641.31997ms","start":"2026-05-26T08:15:24.882279Z","end":"2026-05-26T08:15:25.523599Z","steps":["trace[1312443920] 'process raft request' (duration: 641.163777ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.523872Z","caller":"traceutil/trace.go:171","msg":"trace[1355998871] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"650.931121ms","start":"2026-05-26T08:15:24.872931Z","end":"2026-05-26T08:15:25.523862Z","steps":["trace[1355998871] 'process raft request' (duration: 650.428491ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.523878Z","caller":"traceutil/trace.go:171","msg":"trace[1904462411] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"632.608538ms","start":"2026-05-26T08:15:24.891229Z","end":"2026-05-26T08:15:25.523838Z","steps":["trace[1904462411] 'process raft request' (duration: 632.313172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.52391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.883056Z","time spent":"640.826649ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:25.523917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.872923Z","time spent":"650.971152ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:25.523906Z","caller":"traceutil/trace.go:171","msg":"trace[1471439817] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:512; }","duration":"465.635258ms","start":"2026-05-26T08:15:25.058244Z","end":"2026-05-26T08:15:25.523879Z","steps":["trace[1471439817] 'read index received' (duration: 405.567938ms)","trace[1471439817] 'applied index is now lower than readState.Index' (duration: 60.06632ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:15:25.523968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.891219Z","time spent":"632.690689ms","remote":"127.0.0.1:38754","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-05-26T08:15:25.524003Z","caller":"traceutil/trace.go:171","msg":"trace[1252615344] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"651.749057ms","start":"2026-05-26T08:15:24.872245Z","end":"2026-05-26T08:15:25.523994Z","steps":["trace[1252615344] 'process raft request' (duration: 650.915671ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.524019Z","caller":"traceutil/trace.go:171","msg":"trace[1675267937] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"607.063681ms","start":"2026-05-26T08:15:24.916945Z","end":"2026-05-26T08:15:25.524009Z","steps":["trace[1675267937] 'process raft request' (duration: 606.649723ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:25.524081Z","caller":"traceutil/trace.go:171","msg":"trace[640704125] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"517.018257ms","start":"2026-05-26T08:15:25.007027Z","end":"2026-05-26T08:15:25.524045Z","steps":["trace[640704125] 'process raft request' (duration: 516.703391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.524094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.872223Z","time spent":"651.811637ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:25.524129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:25.006991Z","time spent":"517.118639ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:25.524172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.882273Z","time spent":"641.811949ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:25.524203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.916916Z","time spent":"607.131012ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:25.524253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.000936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-26T08:15:25.523829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.879847Z","time spent":"643.905502ms","remote":"127.0.0.1:38754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T08:15:25.524286Z","caller":"traceutil/trace.go:171","msg":"trace[1382719388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"466.062297ms","start":"2026-05-26T08:15:25.058214Z","end":"2026-05-26T08:15:25.524276Z","steps":["trace[1382719388] 'agreement among raft nodes before linearized reading' (duration: 465.956275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.524133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:24.872021Z","time spent":"651.899749ms","remote":"127.0.0.1:38754","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-05-26T08:15:25.524456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:25.058179Z","time spent":"466.259321ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T08:15:25.532782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.061131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:15:25.532975Z","caller":"traceutil/trace.go:171","msg":"trace[606841183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"446.239575ms","start":"2026-05-26T08:15:25.086696Z","end":"2026-05-26T08:15:25.532936Z","steps":["trace[606841183] 'agreement among raft nodes before linearized reading' (duration: 445.54328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.533223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:25.086622Z","time spent":"446.388267ms","remote":"127.0.0.1:38736","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-26T08:15:25.533245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.568758ms","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-26T08:15:25.533317Z","caller":"traceutil/trace.go:171","msg":"trace[732499779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"347.652211ms","start":"2026-05-26T08:15:25.18565Z","end":"2026-05-26T08:15:25.533302Z","steps":["trace[732499779] 'agreement among raft nodes before linearized reading' (duration: 347.517958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.533363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:25.185617Z","time spent":"347.728961ms","remote":"127.0.0.1:38962","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-26T08:15:25.533717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.418971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-26T08:15:25.533782Z","caller":"traceutil/trace.go:171","msg":"trace[1193158505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"372.551723ms","start":"2026-05-26T08:15:25.161212Z","end":"2026-05-26T08:15:25.533764Z","steps":["trace[1193158505] 'agreement among raft nodes before linearized reading' (duration: 372.018923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:25.53392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:25.161191Z","time spent":"372.718397ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T08:15:31.80121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.229396ms","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-05-26T08:15:31.801209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.904344ms","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-05-26T08:15:31.801323Z","caller":"traceutil/trace.go:171","msg":"trace[541458143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"195.047316ms","start":"2026-05-26T08:15:31.60624Z","end":"2026-05-26T08:15:31.801287Z","steps":["trace[541458143] 'range keys from in-memory index tree' (duration: 194.75895ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:31.801329Z","caller":"traceutil/trace.go:171","msg":"trace[1126779785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"215.367199ms","start":"2026-05-26T08:15:31.585919Z","end":"2026-05-26T08:15:31.801286Z","steps":["trace[1126779785] 'range keys from in-memory index tree' (duration: 214.968081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:31.801329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.095474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T08:15:31.802103Z","caller":"traceutil/trace.go:171","msg":"trace[330660005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"212.462841ms","start":"2026-05-26T08:15:31.589168Z","end":"2026-05-26T08:15:31.801631Z","steps":["trace[330660005] 'range keys from in-memory index tree' (duration: 211.838639ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:32.025255Z","caller":"traceutil/trace.go:171","msg":"trace[1913025279] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"229.06973ms","start":"2026-05-26T08:15:31.796161Z","end":"2026-05-26T08:15:32.025231Z","steps":["trace[1913025279] 'process raft request' (duration: 228.367896ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:32.03476Z","caller":"traceutil/trace.go:171","msg":"trace[937900496] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"165.931118ms","start":"2026-05-26T08:15:31.868809Z","end":"2026-05-26T08:15:32.03474Z","steps":["trace[937900496] 'read index received' (duration: 155.537862ms)","trace[937900496] 'applied index is now lower than readState.Index' (duration: 10.392576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:15:32.034932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.115873ms","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-26T08:15:32.034959Z","caller":"traceutil/trace.go:171","msg":"trace[316311809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"166.210485ms","start":"2026-05-26T08:15:31.868741Z","end":"2026-05-26T08:15:32.034951Z","steps":["trace[316311809] 'agreement among raft nodes before linearized reading' (duration: 166.077103ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:32.034976Z","caller":"traceutil/trace.go:171","msg":"trace[217494777] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"230.291675ms","start":"2026-05-26T08:15:31.804665Z","end":"2026-05-26T08:15:32.034957Z","steps":["trace[217494777] 'process raft request' (duration: 229.944258ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:32.035123Z","caller":"traceutil/trace.go:171","msg":"trace[404625119] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"230.099311ms","start":"2026-05-26T08:15:31.805015Z","end":"2026-05-26T08:15:32.035114Z","steps":["trace[404625119] 'process raft request' (duration: 229.679852ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:32.035187Z","caller":"traceutil/trace.go:171","msg":"trace[871162701] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"229.704793ms","start":"2026-05-26T08:15:31.805476Z","end":"2026-05-26T08:15:32.035181Z","steps":["trace[871162701] 'process raft request' (duration: 229.240583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:32.671564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.525301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:15:32.671659Z","caller":"traceutil/trace.go:171","msg":"trace[132220651] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"631.987766ms","start":"2026-05-26T08:15:32.039653Z","end":"2026-05-26T08:15:32.671641Z","steps":["trace[132220651] 'process raft request' (duration: 346.518787ms)","trace[132220651] 'compare' (duration: 284.400548ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:15:32.671706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:32.039638Z","time spent":"632.045786ms","remote":"127.0.0.1:38962","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-05-26T08:15:32.707106Z","caller":"traceutil/trace.go:171","msg":"trace[2107992443] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"632.6456ms","start":"2026-05-26T08:15:32.074426Z","end":"2026-05-26T08:15:32.707071Z","steps":["trace[2107992443] 'process raft request' (duration: 632.415264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:32.70726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:32.074385Z","time spent":"632.810293ms","remote":"127.0.0.1:38918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:32.707465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.509701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h8n68\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-26T08:15:32.707486Z","caller":"traceutil/trace.go:171","msg":"trace[1493061150] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:630; }","duration":"490.077253ms","start":"2026-05-26T08:15:32.216917Z","end":"2026-05-26T08:15:32.706995Z","steps":["trace[1493061150] 'read index received' (duration: 169.250803ms)","trace[1493061150] 'applied index is now lower than readState.Index' (duration: 320.82261ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:15:32.707571Z","caller":"traceutil/trace.go:171","msg":"trace[848928160] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h8n68; range_end:; response_count:1; response_revision:611; }","duration":"490.662045ms","start":"2026-05-26T08:15:32.216886Z","end":"2026-05-26T08:15:32.707548Z","steps":["trace[848928160] 'agreement among raft nodes before linearized reading' (duration: 490.253227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:32.707621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:32.216875Z","time spent":"490.735106ms","remote":"127.0.0.1:38878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-h8n68\" "} {"level":"warn","ts":"2026-05-26T08:15:33.810991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.834653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:15:33.811197Z","caller":"traceutil/trace.go:171","msg":"trace[1702037636] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.079238071s","start":"2026-05-26T08:15:32.731946Z","end":"2026-05-26T08:15:33.811184Z","steps":["trace[1702037636] 'process raft request' (duration: 1.079136769s)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:15:33.811239Z","caller":"traceutil/trace.go:171","msg":"trace[1710035127] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:632; }","duration":"722.589261ms","start":"2026-05-26T08:15:33.088634Z","end":"2026-05-26T08:15:33.811224Z","steps":["trace[1710035127] 'read index received' (duration: 203.255658ms)","trace[1710035127] 'applied index is now lower than readState.Index' (duration: 519.331713ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:15:33.811319Z","caller":"traceutil/trace.go:171","msg":"trace[702822912] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.08068155s","start":"2026-05-26T08:15:32.730602Z","end":"2026-05-26T08:15:33.811284Z","steps":["trace[702822912] 'process raft request' (duration: 561.422808ms)","trace[702822912] 'compare' (duration: 518.696971ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:15:33.811251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:32.731925Z","time spent":"1.079302073s","remote":"127.0.0.1:38878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:15:33.811356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:32.730577Z","time spent":"1.080759521s","remote":"127.0.0.1:38878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:15:33.811193Z","caller":"traceutil/trace.go:171","msg":"trace[1362977190] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"309.612496ms","start":"2026-05-26T08:15:33.501565Z","end":"2026-05-26T08:15:33.811177Z","steps":["trace[1362977190] 'process raft request' (duration: 309.565555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:33.811445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.823947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:15:33.811467Z","caller":"traceutil/trace.go:171","msg":"trace[1901376963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"722.882827ms","start":"2026-05-26T08:15:33.088576Z","end":"2026-05-26T08:15:33.811459Z","steps":["trace[1901376963] 'agreement among raft nodes before linearized reading' (duration: 722.846946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:33.811477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:33.501534Z","time spent":"309.904742ms","remote":"127.0.0.1:38962","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-05-26T08:15:33.811498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:33.088556Z","time spent":"722.936769ms","remote":"127.0.0.1:38736","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-26T08:15:48.741903Z","caller":"traceutil/trace.go:171","msg":"trace[2049895043] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"422.426402ms","start":"2026-05-26T08:15:48.319456Z","end":"2026-05-26T08:15:48.741883Z","steps":["trace[2049895043] 'process raft request' (duration: 422.221988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:15:48.742058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:15:48.319429Z","time spent":"422.547454ms","remote":"127.0.0.1:38878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:15:48.862788Z","caller":"traceutil/trace.go:171","msg":"trace[792944865] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"116.382146ms","start":"2026-05-26T08:15:48.746376Z","end":"2026-05-26T08:15:48.862759Z","steps":["trace[792944865] 'process raft request' (duration: 108.98537ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:18.486403Z","caller":"traceutil/trace.go:171","msg":"trace[853349437] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"162.981592ms","start":"2026-05-26T08:16:18.323398Z","end":"2026-05-26T08:16:18.486379Z","steps":["trace[853349437] 'process raft request' (duration: 162.933841ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:18.486477Z","caller":"traceutil/trace.go:171","msg":"trace[1629539814] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"163.055073ms","start":"2026-05-26T08:16:18.323401Z","end":"2026-05-26T08:16:18.486456Z","steps":["trace[1629539814] 'process raft request' (duration: 94.786609ms)","trace[1629539814] 'compare' (duration: 68.030489ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:18.725218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.33883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:16:18.725302Z","caller":"traceutil/trace.go:171","msg":"trace[1774213375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"101.479563ms","start":"2026-05-26T08:16:18.623802Z","end":"2026-05-26T08:16:18.725282Z","steps":["trace[1774213375] 'range keys from in-memory index tree' (duration: 101.245248ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:24.961498Z","caller":"traceutil/trace.go:171","msg":"trace[1346739196] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"250.298504ms","start":"2026-05-26T08:16:24.711176Z","end":"2026-05-26T08:16:24.961475Z","steps":["trace[1346739196] 'process raft request' (duration: 250.141791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:25.383216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.090182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:16:25.383223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.367404ms","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-05-26T08:16:25.383318Z","caller":"traceutil/trace.go:171","msg":"trace[186589661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"295.196173ms","start":"2026-05-26T08:16:25.088076Z","end":"2026-05-26T08:16:25.383272Z","steps":["trace[186589661] 'range keys from in-memory index tree' (duration: 295.025931ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:25.383349Z","caller":"traceutil/trace.go:171","msg":"trace[1662460883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:991; }","duration":"312.539157ms","start":"2026-05-26T08:16:25.070788Z","end":"2026-05-26T08:16:25.383327Z","steps":["trace[1662460883] 'range keys from in-memory index tree' (duration: 312.18975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:25.383422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:25.07077Z","time spent":"312.620949ms","remote":"127.0.0.1:38962","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":"info","ts":"2026-05-26T08:16:25.533049Z","caller":"traceutil/trace.go:171","msg":"trace[468661457] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"144.973516ms","start":"2026-05-26T08:16:25.388048Z","end":"2026-05-26T08:16:25.533021Z","steps":["trace[468661457] 'process raft request' (duration: 96.997675ms)","trace[468661457] 'compare' (duration: 47.862289ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:26.48566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.53347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:16:26.485756Z","caller":"traceutil/trace.go:171","msg":"trace[547366887] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"137.69667ms","start":"2026-05-26T08:16:26.348043Z","end":"2026-05-26T08:16:26.48574Z","steps":["trace[547366887] 'read index received' (duration: 25.191µs)","trace[547366887] 'applied index is now lower than readState.Index' (duration: 137.669869ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:16:26.485757Z","caller":"traceutil/trace.go:171","msg":"trace[1562919505] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"774.180511ms","start":"2026-05-26T08:16:25.711563Z","end":"2026-05-26T08:16:26.485743Z","steps":["trace[1562919505] 'process raft request' (duration: 245.485688ms)","trace[1562919505] 'compare' (duration: 528.297596ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:26.485819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:25.711532Z","time spent":"774.258963ms","remote":"127.0.0.1:38962","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-05-26T08:16:26.485879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.839323ms","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-05-26T08:16:26.485905Z","caller":"traceutil/trace.go:171","msg":"trace[1850982408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"137.896704ms","start":"2026-05-26T08:16:26.348Z","end":"2026-05-26T08:16:26.485897Z","steps":["trace[1850982408] 'agreement among raft nodes before linearized reading' (duration: 137.784622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:27.531651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.392271ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:16:27.531768Z","caller":"traceutil/trace.go:171","msg":"trace[965500293] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:994; }","duration":"683.532154ms","start":"2026-05-26T08:16:26.848219Z","end":"2026-05-26T08:16:27.531751Z","steps":["trace[965500293] 'range keys from in-memory index tree' (duration: 683.370661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:27.534488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.87664ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T08:16:27.534752Z","caller":"traceutil/trace.go:171","msg":"trace[355494693] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1027; }","duration":"1.019765222s","start":"2026-05-26T08:16:26.51497Z","end":"2026-05-26T08:16:27.534735Z","steps":["trace[355494693] 'read index received' (duration: 96.648386ms)","trace[355494693] 'applied index is now lower than readState.Index' (duration: 923.115986ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:27.534949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.017183371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-26T08:16:27.534936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.26577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:16:27.534962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019999216s","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-05-26T08:16:27.534979Z","caller":"traceutil/trace.go:171","msg":"trace[1606590513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"1.017250312s","start":"2026-05-26T08:16:26.517719Z","end":"2026-05-26T08:16:27.534969Z","steps":["trace[1606590513] 'agreement among raft nodes before linearized reading' (duration: 1.01712283s)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:27.535001Z","caller":"traceutil/trace.go:171","msg":"trace[320043365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"447.376552ms","start":"2026-05-26T08:16:27.087607Z","end":"2026-05-26T08:16:27.534983Z","steps":["trace[320043365] 'agreement among raft nodes before linearized reading' (duration: 447.259719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:27.535029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:26.517705Z","time spent":"1.017300953s","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T08:16:27.535076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:27.087589Z","time spent":"447.477184ms","remote":"127.0.0.1:38736","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-26T08:16:27.53501Z","caller":"traceutil/trace.go:171","msg":"trace[1373116477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"1.020050437s","start":"2026-05-26T08:16:26.514947Z","end":"2026-05-26T08:16:27.534997Z","steps":["trace[1373116477] 'agreement among raft nodes before linearized reading' (duration: 1.019892444s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:27.535155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:26.514878Z","time spent":"1.020250941s","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T08:16:27.534787Z","caller":"traceutil/trace.go:171","msg":"trace[924535176] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"1.044302968s","start":"2026-05-26T08:16:26.490453Z","end":"2026-05-26T08:16:27.534756Z","steps":["trace[924535176] 'process raft request' (duration: 1.044169235s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:27.535604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:26.490439Z","time spent":"1.045104543s","remote":"127.0.0.1:38962","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-05-26T08:16:47.90953Z","caller":"traceutil/trace.go:171","msg":"trace[1327629487] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"278.703878ms","start":"2026-05-26T08:16:47.630797Z","end":"2026-05-26T08:16:47.909501Z","steps":["trace[1327629487] 'process raft request' (duration: 278.520964ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:48.720024Z","caller":"traceutil/trace.go:171","msg":"trace[65802598] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1098; }","duration":"1.08023954s","start":"2026-05-26T08:16:47.639763Z","end":"2026-05-26T08:16:48.720002Z","steps":["trace[65802598] 'read index received' (duration: 269.517014ms)","trace[65802598] 'applied index is now lower than readState.Index' (duration: 810.721576ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:16:48.720129Z","caller":"traceutil/trace.go:171","msg":"trace[1438556945] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"1.086918623s","start":"2026-05-26T08:16:47.6332Z","end":"2026-05-26T08:16:48.720119Z","steps":["trace[1438556945] 'process raft request' (duration: 1.08675101s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.720234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:47.63319Z","time spent":"1.086969725s","remote":"127.0.0.1:38962","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-05-26T08:16:48.720263Z","caller":"traceutil/trace.go:171","msg":"trace[805054943] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"1.087222699s","start":"2026-05-26T08:16:47.633013Z","end":"2026-05-26T08:16:48.720236Z","steps":["trace[805054943] 'process raft request' (duration: 1.077855033s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.7203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080507126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T08:16:48.720344Z","caller":"traceutil/trace.go:171","msg":"trace[143655677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1063; }","duration":"1.080601598s","start":"2026-05-26T08:16:47.63973Z","end":"2026-05-26T08:16:48.720332Z","steps":["trace[143655677] 'agreement among raft nodes before linearized reading' (duration: 1.080417524s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.720393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:47.632988Z","time spent":"1.087344552s","remote":"127.0.0.1:38962","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-26T08:16:48.720406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:47.63972Z","time spent":"1.080675849s","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T08:16:48.741989Z","caller":"traceutil/trace.go:171","msg":"trace[1562635224] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"183.821274ms","start":"2026-05-26T08:16:48.558127Z","end":"2026-05-26T08:16:48.741948Z","steps":["trace[1562635224] 'process raft request' (duration: 183.653171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.742113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101331118s","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-26T08:16:48.742213Z","caller":"traceutil/trace.go:171","msg":"trace[925859100] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1064; }","duration":"1.10144384s","start":"2026-05-26T08:16:47.640746Z","end":"2026-05-26T08:16:48.74219Z","steps":["trace[925859100] 'agreement among raft nodes before linearized reading' (duration: 1.101222126s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.74229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:47.64074Z","time spent":"1.101535553s","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T08:16:48.742114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.09627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:16:48.742365Z","caller":"traceutil/trace.go:171","msg":"trace[492032100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"654.397516ms","start":"2026-05-26T08:16:48.08795Z","end":"2026-05-26T08:16:48.742347Z","steps":["trace[492032100] 'agreement among raft nodes before linearized reading' (duration: 653.976758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:48.742429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:48.087932Z","time spent":"654.482727ms","remote":"127.0.0.1:38736","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-26T08:16:50.537649Z","caller":"traceutil/trace.go:171","msg":"trace[988895858] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"448.769849ms","start":"2026-05-26T08:16:50.08886Z","end":"2026-05-26T08:16:50.53763Z","steps":["trace[988895858] 'read index received' (duration: 448.039204ms)","trace[988895858] 'applied index is now lower than readState.Index' (duration: 729.825µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:50.537733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.859211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:16:50.537753Z","caller":"traceutil/trace.go:171","msg":"trace[280092834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1067; }","duration":"448.929871ms","start":"2026-05-26T08:16:50.088816Z","end":"2026-05-26T08:16:50.537746Z","steps":["trace[280092834] 'agreement among raft nodes before linearized reading' (duration: 448.87918ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:50.537734Z","caller":"traceutil/trace.go:171","msg":"trace[1951476865] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"619.187179ms","start":"2026-05-26T08:16:49.918514Z","end":"2026-05-26T08:16:50.537701Z","steps":["trace[1951476865] 'process raft request' (duration: 618.443853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:50.537775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.088797Z","time spent":"448.972953ms","remote":"127.0.0.1:38730","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-26T08:16:50.537904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:49.918495Z","time spent":"619.326131ms","remote":"127.0.0.1:38962","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-26T08:16:51.287933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T08:16:51.326849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.13497ms","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-05-26T08:16:51.326977Z","caller":"traceutil/trace.go:171","msg":"trace[13322947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"602.297132ms","start":"2026-05-26T08:16:50.724662Z","end":"2026-05-26T08:16:51.326959Z","steps":["trace[13322947] 'range keys from in-memory index tree' (duration: 601.903656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.327017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.724652Z","time spent":"602.356044ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T08:16:51.327522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.830324ms","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-05-26T08:16:51.327555Z","caller":"traceutil/trace.go:171","msg":"trace[1013667348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1067; }","duration":"602.904626ms","start":"2026-05-26T08:16:50.724641Z","end":"2026-05-26T08:16:51.327545Z","steps":["trace[1013667348] 'range keys from in-memory index tree' (duration: 602.666811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.327582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.724619Z","time spent":"602.956456ms","remote":"127.0.0.1:38962","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":"info","ts":"2026-05-26T08:16:51.346836Z","caller":"traceutil/trace.go:171","msg":"trace[1856362250] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"559.885972ms","start":"2026-05-26T08:16:50.786928Z","end":"2026-05-26T08:16:51.346814Z","steps":["trace[1856362250] 'read index received' (duration: 559.744228ms)","trace[1856362250] 'applied index is now lower than readState.Index' (duration: 140.384µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:16:51.34702Z","caller":"traceutil/trace.go:171","msg":"trace[1206012493] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"598.726293ms","start":"2026-05-26T08:16:50.748268Z","end":"2026-05-26T08:16:51.346994Z","steps":["trace[1206012493] 'process raft request' (duration: 598.420086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.347256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.748242Z","time spent":"598.875466ms","remote":"127.0.0.1:38962","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-05-26T08:16:51.347256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.309631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T08:16:51.347463Z","caller":"traceutil/trace.go:171","msg":"trace[1053370049] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1068; }","duration":"560.519005ms","start":"2026-05-26T08:16:50.786895Z","end":"2026-05-26T08:16:51.347414Z","steps":["trace[1053370049] 'agreement among raft nodes before linearized reading' (duration: 560.067746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.347559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.786883Z","time spent":"560.643727ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T08:16:51.356776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.352005ms","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-26T08:16:51.356838Z","caller":"traceutil/trace.go:171","msg":"trace[695280244] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1070; }","duration":"541.441696ms","start":"2026-05-26T08:16:50.81538Z","end":"2026-05-26T08:16:51.356822Z","steps":["trace[695280244] 'agreement among raft nodes before linearized reading' (duration: 541.244532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.356793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.913902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:16:51.35693Z","caller":"traceutil/trace.go:171","msg":"trace[83302113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1070; }","duration":"269.074895ms","start":"2026-05-26T08:16:51.08784Z","end":"2026-05-26T08:16:51.356915Z","steps":["trace[83302113] 'agreement among raft nodes before linearized reading' (duration: 268.898342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.356963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.608046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T08:16:51.356998Z","caller":"traceutil/trace.go:171","msg":"trace[1556120622] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1070; }","duration":"507.685137ms","start":"2026-05-26T08:16:50.849304Z","end":"2026-05-26T08:16:51.356989Z","steps":["trace[1556120622] 'agreement among raft nodes before linearized reading' (duration: 507.590986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:51.357034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.849282Z","time spent":"507.742959ms","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:16:51.356875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:50.815367Z","time spent":"541.499938ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T08:16:52.735038Z","caller":"traceutil/trace.go:171","msg":"trace[1983957564] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"188.916806ms","start":"2026-05-26T08:16:52.546098Z","end":"2026-05-26T08:16:52.735015Z","steps":["trace[1983957564] 'process raft request' (duration: 188.790384ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:16:53.684764Z","caller":"traceutil/trace.go:171","msg":"trace[1412459278] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"331.646737ms","start":"2026-05-26T08:16:53.353091Z","end":"2026-05-26T08:16:53.684738Z","steps":["trace[1412459278] 'process raft request' (duration: 331.381871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:53.684932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:53.353064Z","time spent":"331.777139ms","remote":"127.0.0.1:38962","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-05-26T08:16:53.685322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.656818ms","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-05-26T08:16:53.685378Z","caller":"traceutil/trace.go:171","msg":"trace[942648863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1075; }","duration":"325.75222ms","start":"2026-05-26T08:16:53.359611Z","end":"2026-05-26T08:16:53.685364Z","steps":["trace[942648863] 'agreement among raft nodes before linearized reading' (duration: 325.384151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:53.685421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:53.359593Z","time spent":"325.816971ms","remote":"127.0.0.1:38962","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":"info","ts":"2026-05-26T08:16:53.684951Z","caller":"traceutil/trace.go:171","msg":"trace[610189568] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"324.973604ms","start":"2026-05-26T08:16:53.359669Z","end":"2026-05-26T08:16:53.684643Z","steps":["trace[610189568] 'read index received' (duration: 324.690628ms)","trace[610189568] 'applied index is now lower than readState.Index' (duration: 281.916µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:16:53.685957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.962739ms","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-26T08:16:53.685992Z","caller":"traceutil/trace.go:171","msg":"trace[113346048] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1075; }","duration":"293.03768ms","start":"2026-05-26T08:16:53.392946Z","end":"2026-05-26T08:16:53.685984Z","steps":["trace[113346048] 'agreement among raft nodes before linearized reading' (duration: 292.932688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:53.685981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.974966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T08:16:53.686027Z","caller":"traceutil/trace.go:171","msg":"trace[1554160984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1075; }","duration":"311.045018ms","start":"2026-05-26T08:16:53.374969Z","end":"2026-05-26T08:16:53.686014Z","steps":["trace[1554160984] 'agreement among raft nodes before linearized reading' (duration: 310.935736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:53.686064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:53.374926Z","time spent":"311.12872ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T08:16:53.686251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.997733ms","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-05-26T08:16:53.686376Z","caller":"traceutil/trace.go:171","msg":"trace[1838652713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1075; }","duration":"326.095015ms","start":"2026-05-26T08:16:53.360231Z","end":"2026-05-26T08:16:53.686326Z","steps":["trace[1838652713] 'agreement among raft nodes before linearized reading' (duration: 325.578455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:16:53.686451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:16:53.360225Z","time spent":"326.210679ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T08:17:06.212883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.331076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:06.212997Z","caller":"traceutil/trace.go:171","msg":"trace[912131594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1120; }","duration":"121.469639ms","start":"2026-05-26T08:17:06.091502Z","end":"2026-05-26T08:17:06.212972Z","steps":["trace[912131594] 'range keys from in-memory index tree' (duration: 121.277206ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:11.242356Z","caller":"traceutil/trace.go:171","msg":"trace[1386224724] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"360.500658ms","start":"2026-05-26T08:17:10.881832Z","end":"2026-05-26T08:17:11.242333Z","steps":["trace[1386224724] 'read index received' (duration: 360.318094ms)","trace[1386224724] 'applied index is now lower than readState.Index' (duration: 181.764µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:11.242491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.6346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:11.242527Z","caller":"traceutil/trace.go:171","msg":"trace[552689905] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1184; }","duration":"360.713252ms","start":"2026-05-26T08:17:10.881802Z","end":"2026-05-26T08:17:11.242515Z","steps":["trace[552689905] 'agreement among raft nodes before linearized reading' (duration: 360.621211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:11.242575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:10.881789Z","time spent":"360.763073ms","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-26T08:17:11.242894Z","caller":"traceutil/trace.go:171","msg":"trace[1088053138] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"406.45926ms","start":"2026-05-26T08:17:10.836423Z","end":"2026-05-26T08:17:11.242882Z","steps":["trace[1088053138] 'process raft request' (duration: 405.787587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:11.24298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:10.836403Z","time spent":"406.523472ms","remote":"127.0.0.1:38962","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-26T08:17:11.85406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.923705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T08:17:11.85415Z","caller":"traceutil/trace.go:171","msg":"trace[65953046] range","detail":"{range_begin:/registry/masterleases/199.19.213.102; range_end:; response_count:1; response_revision:1184; }","duration":"490.073388ms","start":"2026-05-26T08:17:11.364055Z","end":"2026-05-26T08:17:11.854129Z","steps":["trace[65953046] 'range keys from in-memory index tree' (duration: 489.68153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:11.854195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:11.364036Z","time spent":"490.14992ms","remote":"127.0.0.1:38744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.102\" "} {"level":"info","ts":"2026-05-26T08:17:11.860232Z","caller":"traceutil/trace.go:171","msg":"trace[1533780569] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"113.880719ms","start":"2026-05-26T08:17:11.74634Z","end":"2026-05-26T08:17:11.86022Z","steps":["trace[1533780569] 'process raft request' (duration: 113.793206ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:11.860244Z","caller":"traceutil/trace.go:171","msg":"trace[39664272] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1229; }","duration":"113.230296ms","start":"2026-05-26T08:17:11.74699Z","end":"2026-05-26T08:17:11.86022Z","steps":["trace[39664272] 'read index received' (duration: 113.221186ms)","trace[39664272] 'applied index is now lower than readState.Index' (duration: 7.38µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:11.860381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.384788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:11.860421Z","caller":"traceutil/trace.go:171","msg":"trace[914438950] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1185; }","duration":"113.49312ms","start":"2026-05-26T08:17:11.746918Z","end":"2026-05-26T08:17:11.860411Z","steps":["trace[914438950] 'agreement among raft nodes before linearized reading' (duration: 113.384298ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:23.422175Z","caller":"traceutil/trace.go:171","msg":"trace[1849153579] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"117.299906ms","start":"2026-05-26T08:17:23.304854Z","end":"2026-05-26T08:17:23.422154Z","steps":["trace[1849153579] 'process raft request' (duration: 117.193164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.284546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.059695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:24.284647Z","caller":"traceutil/trace.go:171","msg":"trace[1051649144] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"337.87425ms","start":"2026-05-26T08:17:23.946755Z","end":"2026-05-26T08:17:24.284629Z","steps":["trace[1051649144] 'read index received' (duration: 67.57047ms)","trace[1051649144] 'applied index is now lower than readState.Index' (duration: 270.30273ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:24.284869Z","caller":"traceutil/trace.go:171","msg":"trace[349465309] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"340.167485ms","start":"2026-05-26T08:17:23.944684Z","end":"2026-05-26T08:17:24.284851Z","steps":["trace[349465309] 'process raft request' (duration: 69.717792ms)","trace[349465309] 'compare' (duration: 269.894822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:24.284935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:23.944664Z","time spent":"340.239927ms","remote":"127.0.0.1:38962","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-26T08:17:24.285183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.423601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T08:17:24.285218Z","caller":"traceutil/trace.go:171","msg":"trace[1762300403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1226; }","duration":"338.481512ms","start":"2026-05-26T08:17:23.946727Z","end":"2026-05-26T08:17:24.285208Z","steps":["trace[1762300403] 'agreement among raft nodes before linearized reading' (duration: 338.36597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.285246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:23.946716Z","time spent":"338.523573ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T08:17:24.650444Z","caller":"traceutil/trace.go:171","msg":"trace[241946275] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1273; }","duration":"365.742123ms","start":"2026-05-26T08:17:24.284677Z","end":"2026-05-26T08:17:24.650419Z","steps":["trace[241946275] 'read index received' (duration: 365.64264ms)","trace[241946275] 'applied index is now lower than readState.Index' (duration: 98.223µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:24.650657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.349099ms","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-05-26T08:17:24.650711Z","caller":"traceutil/trace.go:171","msg":"trace[828625248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1227; }","duration":"696.43932ms","start":"2026-05-26T08:17:23.954256Z","end":"2026-05-26T08:17:24.650695Z","steps":["trace[828625248] 'agreement among raft nodes before linearized reading' (duration: 696.259076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.650764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:23.954214Z","time spent":"696.534162ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T08:17:24.650941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.500004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:24.65099Z","caller":"traceutil/trace.go:171","msg":"trace[1708805809] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1227; }","duration":"619.557465ms","start":"2026-05-26T08:17:24.031421Z","end":"2026-05-26T08:17:24.650979Z","steps":["trace[1708805809] 'agreement among raft nodes before linearized reading' (duration: 619.477234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.651027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.031363Z","time spent":"619.651577ms","remote":"127.0.0.1:50520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:24.651041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.449713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:24.65147Z","caller":"traceutil/trace.go:171","msg":"trace[1488557276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1227; }","duration":"560.688367ms","start":"2026-05-26T08:17:24.09049Z","end":"2026-05-26T08:17:24.651178Z","steps":["trace[1488557276] 'agreement among raft nodes before linearized reading' (duration: 560.038765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.651574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.198846ms","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-05-26T08:17:24.651631Z","caller":"traceutil/trace.go:171","msg":"trace[554589248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1227; }","duration":"690.298438ms","start":"2026-05-26T08:17:23.961319Z","end":"2026-05-26T08:17:24.651618Z","steps":["trace[554589248] 'agreement among raft nodes before linearized reading' (duration: 690.122174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.651664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:23.961305Z","time spent":"690.354329ms","remote":"127.0.0.1:38962","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":"info","ts":"2026-05-26T08:17:24.651743Z","caller":"traceutil/trace.go:171","msg":"trace[656434290] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"368.65244ms","start":"2026-05-26T08:17:24.283085Z","end":"2026-05-26T08:17:24.651737Z","steps":["trace[656434290] 'process raft request' (duration: 367.13699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:24.651799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.28306Z","time spent":"368.69847ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:24.651661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.090472Z","time spent":"561.113146ms","remote":"127.0.0.1:38736","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-26T08:17:25.041837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.994065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:25.041978Z","caller":"traceutil/trace.go:171","msg":"trace[325054236] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"388.216278ms","start":"2026-05-26T08:17:24.653739Z","end":"2026-05-26T08:17:25.041956Z","steps":["trace[325054236] 'read index received' (duration: 185.978028ms)","trace[325054236] 'applied index is now lower than readState.Index' (duration: 202.23654ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:25.042084Z","caller":"traceutil/trace.go:171","msg":"trace[1639360270] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"752.815807ms","start":"2026-05-26T08:17:24.289236Z","end":"2026-05-26T08:17:25.042052Z","steps":["trace[1639360270] 'process raft request' (duration: 550.469245ms)","trace[1639360270] 'compare' (duration: 201.691879ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:25.042152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.405992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:25.0422Z","caller":"traceutil/trace.go:171","msg":"trace[1481123239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1228; }","duration":"388.489173ms","start":"2026-05-26T08:17:24.653696Z","end":"2026-05-26T08:17:25.042185Z","steps":["trace[1481123239] 'agreement among raft nodes before linearized reading' (duration: 388.363291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:25.042233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.289219Z","time spent":"752.93061ms","remote":"127.0.0.1:38962","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-26T08:17:25.042246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.653673Z","time spent":"388.562144ms","remote":"127.0.0.1:38730","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-26T08:17:25.384059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.954711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:25.384272Z","caller":"traceutil/trace.go:171","msg":"trace[841586261] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1275; }","duration":"342.236947ms","start":"2026-05-26T08:17:25.042014Z","end":"2026-05-26T08:17:25.384251Z","steps":["trace[841586261] 'read index received' (duration: 178.924868ms)","trace[841586261] 'applied index is now lower than readState.Index' (duration: 163.310929ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:25.384375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.662928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:25.384384Z","caller":"traceutil/trace.go:171","msg":"trace[400124275] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"726.446465ms","start":"2026-05-26T08:17:24.657916Z","end":"2026-05-26T08:17:25.384363Z","steps":["trace[400124275] 'process raft request' (duration: 563.093746ms)","trace[400124275] 'compare' (duration: 162.821808ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:25.384424Z","caller":"traceutil/trace.go:171","msg":"trace[192920147] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1230; }","duration":"614.75478ms","start":"2026-05-26T08:17:24.769656Z","end":"2026-05-26T08:17:25.384411Z","steps":["trace[192920147] 'agreement among raft nodes before linearized reading' (duration: 614.673809ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:25.384408Z","caller":"traceutil/trace.go:171","msg":"trace[1985830539] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"726.466866ms","start":"2026-05-26T08:17:24.657916Z","end":"2026-05-26T08:17:25.384383Z","steps":["trace[1985830539] 'process raft request' (duration: 726.247811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:25.38447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.657895Z","time spent":"726.532166ms","remote":"127.0.0.1:38962","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-05-26T08:17:25.384476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.769636Z","time spent":"614.821751ms","remote":"127.0.0.1:39014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:25.384534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:24.657895Z","time spent":"726.570617ms","remote":"127.0.0.1:38962","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-26T08:17:25.826479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.294319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:25.826645Z","caller":"traceutil/trace.go:171","msg":"trace[1235890476] linearizableReadLoop","detail":"{readStateIndex:1278; appliedIndex:1277; }","duration":"265.811241ms","start":"2026-05-26T08:17:25.560819Z","end":"2026-05-26T08:17:25.82663Z","steps":["trace[1235890476] 'read index received' (duration: 48.381µs)","trace[1235890476] 'applied index is now lower than readState.Index' (duration: 265.76172ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:25.826673Z","caller":"traceutil/trace.go:171","msg":"trace[1083121740] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"398.007652ms","start":"2026-05-26T08:17:25.428639Z","end":"2026-05-26T08:17:25.826646Z","steps":["trace[1083121740] 'process raft request' (duration: 126.474708ms)","trace[1083121740] 'compare' (duration: 270.974513ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:25.826809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:25.428622Z","time spent":"398.117375ms","remote":"127.0.0.1:38962","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-26T08:17:25.826947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.043395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:25.827092Z","caller":"traceutil/trace.go:171","msg":"trace[472714851] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1231; }","duration":"266.28745ms","start":"2026-05-26T08:17:25.56076Z","end":"2026-05-26T08:17:25.827048Z","steps":["trace[472714851] 'agreement among raft nodes before linearized reading' (duration: 266.003085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:26.790072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017503,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T08:17:26.794964Z","caller":"traceutil/trace.go:171","msg":"trace[1227662987] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"505.610365ms","start":"2026-05-26T08:17:26.289329Z","end":"2026-05-26T08:17:26.79494Z","steps":["trace[1227662987] 'read index received' (duration: 505.32983ms)","trace[1227662987] 'applied index is now lower than readState.Index' (duration: 279.205µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:26.795225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.86913ms","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-26T08:17:26.795325Z","caller":"traceutil/trace.go:171","msg":"trace[152486699] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"505.989093ms","start":"2026-05-26T08:17:26.289287Z","end":"2026-05-26T08:17:26.795276Z","steps":["trace[152486699] 'agreement among raft nodes before linearized reading' (duration: 505.732628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:26.795376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:26.289269Z","time spent":"506.095206ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T08:17:26.795685Z","caller":"traceutil/trace.go:171","msg":"trace[509445550] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"656.59511ms","start":"2026-05-26T08:17:26.139078Z","end":"2026-05-26T08:17:26.795673Z","steps":["trace[509445550] 'process raft request' (duration: 655.693902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:26.795775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:26.139052Z","time spent":"656.670171ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:29.559979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.462739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:29.560153Z","caller":"traceutil/trace.go:171","msg":"trace[200401019] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"159.086264ms","start":"2026-05-26T08:17:29.401048Z","end":"2026-05-26T08:17:29.560134Z","steps":["trace[200401019] 'process raft request' (duration: 159.035804ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:29.560375Z","caller":"traceutil/trace.go:171","msg":"trace[209726329] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"160.919001ms","start":"2026-05-26T08:17:29.399427Z","end":"2026-05-26T08:17:29.560346Z","steps":["trace[209726329] 'process raft request' (duration: 40.013543ms)","trace[209726329] 'compare' (duration: 120.349997ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:32.350957Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017612,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T08:17:32.522691Z","caller":"traceutil/trace.go:171","msg":"trace[1111395502] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"706.549621ms","start":"2026-05-26T08:17:31.816116Z","end":"2026-05-26T08:17:32.522665Z","steps":["trace[1111395502] 'process raft request' (duration: 706.364597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.522848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:31.816089Z","time spent":"706.681184ms","remote":"127.0.0.1:38878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:17:32.720706Z","caller":"traceutil/trace.go:171","msg":"trace[275395329] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1339; }","duration":"870.014772ms","start":"2026-05-26T08:17:31.850642Z","end":"2026-05-26T08:17:32.720657Z","steps":["trace[275395329] 'read index received' (duration: 671.849133ms)","trace[275395329] 'applied index is now lower than readState.Index' (duration: 198.163699ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:32.720785Z","caller":"traceutil/trace.go:171","msg":"trace[1567202795] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"653.002259ms","start":"2026-05-26T08:17:32.067729Z","end":"2026-05-26T08:17:32.720731Z","steps":["trace[1567202795] 'process raft request' (duration: 631.064734ms)","trace[1567202795] 'compare' (duration: 21.484356ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:32.720976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:32.067704Z","time spent":"653.159012ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:32.720972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.319359ms","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-26T08:17:32.721059Z","caller":"traceutil/trace.go:171","msg":"trace[411872341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1292; }","duration":"870.451071ms","start":"2026-05-26T08:17:31.850589Z","end":"2026-05-26T08:17:32.721041Z","steps":["trace[411872341] 'agreement among raft nodes before linearized reading' (duration: 870.201127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.721104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:31.850563Z","time spent":"870.528932ms","remote":"127.0.0.1:38962","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-26T08:17:32.727306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.560558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-05-26T08:17:32.727347Z","caller":"traceutil/trace.go:171","msg":"trace[1649653981] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"197.269832ms","start":"2026-05-26T08:17:32.530067Z","end":"2026-05-26T08:17:32.727337Z","steps":["trace[1649653981] 'process raft request' (duration: 197.033997ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:32.72736Z","caller":"traceutil/trace.go:171","msg":"trace[1606188513] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1293; }","duration":"198.65769ms","start":"2026-05-26T08:17:32.528689Z","end":"2026-05-26T08:17:32.727346Z","steps":["trace[1606188513] 'agreement among raft nodes before linearized reading' (duration: 198.510617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.727334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.090724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T08:17:32.727312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.303709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"info","ts":"2026-05-26T08:17:32.727453Z","caller":"traceutil/trace.go:171","msg":"trace[965778091] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1293; }","duration":"164.280598ms","start":"2026-05-26T08:17:32.563153Z","end":"2026-05-26T08:17:32.727434Z","steps":["trace[965778091] 'agreement among raft nodes before linearized reading' (duration: 164.082944ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:32.72748Z","caller":"traceutil/trace.go:171","msg":"trace[1836071549] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1293; }","duration":"100.527923ms","start":"2026-05-26T08:17:32.62694Z","end":"2026-05-26T08:17:32.727468Z","steps":["trace[1836071549] 'agreement among raft nodes before linearized reading' (duration: 100.264448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.727456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.895185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-05-26T08:17:32.727579Z","caller":"traceutil/trace.go:171","msg":"trace[773353007] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1293; }","duration":"196.053418ms","start":"2026-05-26T08:17:32.531498Z","end":"2026-05-26T08:17:32.727552Z","steps":["trace[773353007] 'agreement among raft nodes before linearized reading' (duration: 195.820294ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:32.952162Z","caller":"traceutil/trace.go:171","msg":"trace[1441159303] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"195.874084ms","start":"2026-05-26T08:17:32.75626Z","end":"2026-05-26T08:17:32.952135Z","steps":["trace[1441159303] 'read index received' (duration: 98.396271ms)","trace[1441159303] 'applied index is now lower than readState.Index' (duration: 97.476303ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:32.95232Z","caller":"traceutil/trace.go:171","msg":"trace[1875908340] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"219.318719ms","start":"2026-05-26T08:17:32.732989Z","end":"2026-05-26T08:17:32.952307Z","steps":["trace[1875908340] 'process raft request' (duration: 121.719424ms)","trace[1875908340] 'compare' (duration: 97.112206ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:32.95257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.709645ms","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-26T08:17:32.95262Z","caller":"traceutil/trace.go:171","msg":"trace[1885735399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1295; }","duration":"113.816807ms","start":"2026-05-26T08:17:32.838789Z","end":"2026-05-26T08:17:32.952606Z","steps":["trace[1885735399] 'agreement among raft nodes before linearized reading' (duration: 113.653654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.952691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.998163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-05-26T08:17:32.952762Z","caller":"traceutil/trace.go:171","msg":"trace[560079487] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1295; }","duration":"221.082334ms","start":"2026-05-26T08:17:32.73166Z","end":"2026-05-26T08:17:32.952743Z","steps":["trace[560079487] 'agreement among raft nodes before linearized reading' (duration: 220.939982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:32.952943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.788141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2723"} {"level":"info","ts":"2026-05-26T08:17:32.953016Z","caller":"traceutil/trace.go:171","msg":"trace[1673842346] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1295; }","duration":"146.911193ms","start":"2026-05-26T08:17:32.806089Z","end":"2026-05-26T08:17:32.953Z","steps":["trace[1673842346] 'agreement among raft nodes before linearized reading' (duration: 146.279081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:33.175214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.964029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:33.175504Z","caller":"traceutil/trace.go:171","msg":"trace[1122966913] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1344; }","duration":"100.202877ms","start":"2026-05-26T08:17:33.075267Z","end":"2026-05-26T08:17:33.175469Z","steps":["trace[1122966913] 'read index received' (duration: 28.406223ms)","trace[1122966913] 'applied index is now lower than readState.Index' (duration: 71.795694ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:33.175706Z","caller":"traceutil/trace.go:171","msg":"trace[1833350050] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"217.851579ms","start":"2026-05-26T08:17:32.957817Z","end":"2026-05-26T08:17:33.175669Z","steps":["trace[1833350050] 'process raft request' (duration: 99.329519ms)","trace[1833350050] 'compare' (duration: 117.794646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:33.175788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.525093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-26T08:17:33.175967Z","caller":"traceutil/trace.go:171","msg":"trace[1433090322] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"100.735008ms","start":"2026-05-26T08:17:33.075217Z","end":"2026-05-26T08:17:33.175952Z","steps":["trace[1433090322] 'agreement among raft nodes before linearized reading' (duration: 100.38412ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:33.176161Z","caller":"traceutil/trace.go:171","msg":"trace[1031697072] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"213.641886ms","start":"2026-05-26T08:17:32.962495Z","end":"2026-05-26T08:17:33.176137Z","steps":["trace[1031697072] 'process raft request' (duration: 212.903111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:33.842808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.176258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:33.842915Z","caller":"traceutil/trace.go:171","msg":"trace[145393807] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"300.636131ms","start":"2026-05-26T08:17:33.542261Z","end":"2026-05-26T08:17:33.842898Z","steps":["trace[145393807] 'read index received' (duration: 55.571µs)","trace[145393807] 'applied index is now lower than readState.Index' (duration: 300.57939ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:33.842995Z","caller":"traceutil/trace.go:171","msg":"trace[63693788] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"663.542517ms","start":"2026-05-26T08:17:33.179441Z","end":"2026-05-26T08:17:33.842984Z","steps":["trace[63693788] 'process raft request' (duration: 219.088945ms)","trace[63693788] 'compare' (duration: 443.82481ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:33.843058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:33.179411Z","time spent":"663.615629ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:33.843281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.001279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:17:33.843378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.390842ms","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-05-26T08:17:33.843393Z","caller":"traceutil/trace.go:171","msg":"trace[1478047291] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1298; }","duration":"301.142141ms","start":"2026-05-26T08:17:33.542228Z","end":"2026-05-26T08:17:33.84337Z","steps":["trace[1478047291] 'agreement among raft nodes before linearized reading' (duration: 300.969208ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:33.843438Z","caller":"traceutil/trace.go:171","msg":"trace[398132578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"267.497324ms","start":"2026-05-26T08:17:33.575921Z","end":"2026-05-26T08:17:33.843418Z","steps":["trace[398132578] 'agreement among raft nodes before linearized reading' (duration: 267.29129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:33.843448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:33.542212Z","time spent":"301.218083ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:33.843455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.27677ms","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-05-26T08:17:33.843558Z","caller":"traceutil/trace.go:171","msg":"trace[463813689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1298; }","duration":"267.407393ms","start":"2026-05-26T08:17:33.576129Z","end":"2026-05-26T08:17:33.843536Z","steps":["trace[463813689] 'agreement among raft nodes before linearized reading' (duration: 267.117627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:34.929838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.867572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:34.930396Z","caller":"traceutil/trace.go:171","msg":"trace[1585581117] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1347; }","duration":"837.829785ms","start":"2026-05-26T08:17:34.092548Z","end":"2026-05-26T08:17:34.930377Z","steps":["trace[1585581117] 'read index received' (duration: 103.229717ms)","trace[1585581117] 'applied index is now lower than readState.Index' (duration: 734.599158ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:34.930544Z","caller":"traceutil/trace.go:171","msg":"trace[399043216] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"1.083064567s","start":"2026-05-26T08:17:33.847462Z","end":"2026-05-26T08:17:34.930527Z","steps":["trace[399043216] 'process raft request' (duration: 348.403808ms)","trace[399043216] 'compare' (duration: 733.74036ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:34.930688Z","caller":"traceutil/trace.go:171","msg":"trace[1154328031] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"1.082765392s","start":"2026-05-26T08:17:33.847864Z","end":"2026-05-26T08:17:34.930629Z","steps":["trace[1154328031] 'process raft request' (duration: 1.082447306s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:34.930867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:33.847847Z","time spent":"1.082926824s","remote":"127.0.0.1:38962","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-05-26T08:17:34.930979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.421576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T08:17:34.931055Z","caller":"traceutil/trace.go:171","msg":"trace[407239040] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1300; }","duration":"838.540588ms","start":"2026-05-26T08:17:34.092498Z","end":"2026-05-26T08:17:34.931038Z","steps":["trace[407239040] 'agreement among raft nodes before linearized reading' (duration: 838.372855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:34.931153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.092477Z","time spent":"838.6219ms","remote":"127.0.0.1:38792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:34.930846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:33.847433Z","time spent":"1.08321905s","remote":"127.0.0.1:38962","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-26T08:17:34.937005Z","caller":"traceutil/trace.go:171","msg":"trace[1940224599] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"208.836501ms","start":"2026-05-26T08:17:34.728152Z","end":"2026-05-26T08:17:34.936989Z","steps":["trace[1940224599] 'process raft request' (duration: 208.79896ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:34.93711Z","caller":"traceutil/trace.go:171","msg":"trace[1565914820] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"458.611123ms","start":"2026-05-26T08:17:34.478479Z","end":"2026-05-26T08:17:34.93709Z","steps":["trace[1565914820] 'process raft request' (duration: 458.404279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:34.93721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.478446Z","time spent":"458.722765ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T08:17:35.284903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.383968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:35.285106Z","caller":"traceutil/trace.go:171","msg":"trace[1793976830] linearizableReadLoop","detail":"{readStateIndex:1352; appliedIndex:1349; }","duration":"354.599801ms","start":"2026-05-26T08:17:34.93049Z","end":"2026-05-26T08:17:35.28509Z","steps":["trace[1793976830] 'read index received' (duration: 6.398456ms)","trace[1793976830] 'applied index is now lower than readState.Index' (duration: 348.199605ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:35.28531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.435345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:17:35.285331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.324055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T08:17:35.285413Z","caller":"traceutil/trace.go:171","msg":"trace[167228978] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1303; }","duration":"769.473608ms","start":"2026-05-26T08:17:34.515922Z","end":"2026-05-26T08:17:35.285395Z","steps":["trace[167228978] 'agreement among raft nodes before linearized reading' (duration: 769.297415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.285425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.139708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:17:35.285464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.515904Z","time spent":"769.549119ms","remote":"127.0.0.1:50738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-05-26T08:17:35.285475Z","caller":"traceutil/trace.go:171","msg":"trace[2121900084] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"406.093833ms","start":"2026-05-26T08:17:34.879338Z","end":"2026-05-26T08:17:35.285432Z","steps":["trace[2121900084] 'process raft request' (duration: 292.096063ms)","trace[2121900084] 'compare' (duration: 113.164154ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:35.285485Z","caller":"traceutil/trace.go:171","msg":"trace[195818495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1303; }","duration":"261.322731ms","start":"2026-05-26T08:17:35.024148Z","end":"2026-05-26T08:17:35.28547Z","steps":["trace[195818495] 'agreement among raft nodes before linearized reading' (duration: 261.170938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.285497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.254376ms","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-26T08:17:35.285554Z","caller":"traceutil/trace.go:171","msg":"trace[1430063551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1303; }","duration":"839.553688ms","start":"2026-05-26T08:17:34.445821Z","end":"2026-05-26T08:17:35.285375Z","steps":["trace[1430063551] 'agreement among raft nodes before linearized reading' (duration: 839.417765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.285588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.879282Z","time spent":"406.237645ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:17:35.28556Z","caller":"traceutil/trace.go:171","msg":"trace[1085668744] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1303; }","duration":"104.364809ms","start":"2026-05-26T08:17:35.181182Z","end":"2026-05-26T08:17:35.285547Z","steps":["trace[1085668744] 'agreement among raft nodes before linearized reading' (duration: 104.174975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.285702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.445799Z","time spent":"839.851903ms","remote":"127.0.0.1:50536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:35.285565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.229765ms","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-26T08:17:35.28577Z","caller":"traceutil/trace.go:171","msg":"trace[432244801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1303; }","duration":"524.475099ms","start":"2026-05-26T08:17:34.761282Z","end":"2026-05-26T08:17:35.285757Z","steps":["trace[432244801] 'agreement among raft nodes before linearized reading' (duration: 524.147663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.28581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.761262Z","time spent":"524.535381ms","remote":"127.0.0.1:38962","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-26T08:17:35.285603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104641315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:35.285849Z","caller":"traceutil/trace.go:171","msg":"trace[544128223] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1303; }","duration":"1.104922581s","start":"2026-05-26T08:17:34.180915Z","end":"2026-05-26T08:17:35.285837Z","steps":["trace[544128223] 'agreement among raft nodes before linearized reading' (duration: 1.104664545s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:35.285968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:34.180893Z","time spent":"1.104988832s","remote":"127.0.0.1:38918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:35.285642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.555037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:35.286041Z","caller":"traceutil/trace.go:171","msg":"trace[713902691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1303; }","duration":"198.959315ms","start":"2026-05-26T08:17:35.087058Z","end":"2026-05-26T08:17:35.286018Z","steps":["trace[713902691] 'agreement among raft nodes before linearized reading' (duration: 198.570636ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:36.094665Z","caller":"traceutil/trace.go:171","msg":"trace[1449485562] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"247.674612ms","start":"2026-05-26T08:17:35.846973Z","end":"2026-05-26T08:17:36.094648Z","steps":["trace[1449485562] 'read index received' (duration: 247.510039ms)","trace[1449485562] 'applied index is now lower than readState.Index' (duration: 163.923µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:36.09472Z","caller":"traceutil/trace.go:171","msg":"trace[818945709] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"424.314594ms","start":"2026-05-26T08:17:35.670375Z","end":"2026-05-26T08:17:36.09469Z","steps":["trace[818945709] 'process raft request' (duration: 424.161431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:36.094881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.898266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-26T08:17:36.094873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:35.670355Z","time spent":"424.430676ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:17:36.094911Z","caller":"traceutil/trace.go:171","msg":"trace[987894791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1306; }","duration":"247.980878ms","start":"2026-05-26T08:17:35.846922Z","end":"2026-05-26T08:17:36.094903Z","steps":["trace[987894791] 'agreement among raft nodes before linearized reading' (duration: 247.819154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:36.685134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.349752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:36.685239Z","caller":"traceutil/trace.go:171","msg":"trace[1083117104] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"584.299916ms","start":"2026-05-26T08:17:36.100921Z","end":"2026-05-26T08:17:36.68522Z","steps":["trace[1083117104] 'process raft request' (duration: 260.787461ms)","trace[1083117104] 'compare' (duration: 322.844141ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:36.685297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.100901Z","time spent":"584.370318ms","remote":"127.0.0.1:38962","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-26T08:17:36.899452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T08:17:37.400602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T08:17:37.588224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.379562ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:37.588382Z","caller":"traceutil/trace.go:171","msg":"trace[123508840] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1307; }","duration":"740.575985ms","start":"2026-05-26T08:17:36.84778Z","end":"2026-05-26T08:17:37.588356Z","steps":["trace[123508840] 'range keys from in-memory index tree' (duration: 740.361191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:37.652298Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.271658407s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T08:17:37.652696Z","caller":"traceutil/trace.go:171","msg":"trace[355042643] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"1.272179337s","start":"2026-05-26T08:17:36.380493Z","end":"2026-05-26T08:17:37.652672Z","steps":["trace[355042643] 'process raft request' (duration: 1.272042444s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:37.652844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.38047Z","time spent":"1.272291379s","remote":"127.0.0.1:38876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6263,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:38.070181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.549286ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T08:17:38.070861Z","caller":"traceutil/trace.go:171","msg":"trace[1166863436] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"1.12862426s","start":"2026-05-26T08:17:36.942214Z","end":"2026-05-26T08:17:38.070839Z","steps":["trace[1166863436] 'process raft request' (duration: 1.128428285s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.071115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.942188Z","time spent":"1.128785102s","remote":"127.0.0.1:38962","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-05-26T08:17:38.071222Z","caller":"traceutil/trace.go:171","msg":"trace[1199541955] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"277.476731ms","start":"2026-05-26T08:17:37.79372Z","end":"2026-05-26T08:17:38.071197Z","steps":["trace[1199541955] 'process raft request' (duration: 277.38684ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:38.071222Z","caller":"traceutil/trace.go:171","msg":"trace[883027795] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"958.485926ms","start":"2026-05-26T08:17:37.112701Z","end":"2026-05-26T08:17:38.071187Z","steps":["trace[883027795] 'process raft request' (duration: 958.082719ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:38.071253Z","caller":"traceutil/trace.go:171","msg":"trace[1323570759] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1356; }","duration":"1.672591866s","start":"2026-05-26T08:17:36.398642Z","end":"2026-05-26T08:17:38.071234Z","steps":["trace[1323570759] 'read index received' (duration: 1.253908894s)","trace[1323570759] 'applied index is now lower than readState.Index' (duration: 418.680232ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:38.071437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:37.112682Z","time spent":"958.71784ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:38.071458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.672801271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:38.07155Z","caller":"traceutil/trace.go:171","msg":"trace[1284782577] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1311; }","duration":"1.672938043s","start":"2026-05-26T08:17:36.398602Z","end":"2026-05-26T08:17:38.07154Z","steps":["trace[1284782577] 'agreement among raft nodes before linearized reading' (duration: 1.672716459s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.071622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.398583Z","time spent":"1.673029815s","remote":"127.0.0.1:39024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:38.071726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.712201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:38.071779Z","caller":"traceutil/trace.go:171","msg":"trace[223483957] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1311; }","duration":"190.795862ms","start":"2026-05-26T08:17:37.880974Z","end":"2026-05-26T08:17:38.07177Z","steps":["trace[223483957] 'agreement among raft nodes before linearized reading' (duration: 190.727191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.071788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.344543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:38.071834Z","caller":"traceutil/trace.go:171","msg":"trace[1320668640] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1311; }","duration":"429.422784ms","start":"2026-05-26T08:17:37.642399Z","end":"2026-05-26T08:17:38.071822Z","steps":["trace[1320668640] 'agreement among raft nodes before linearized reading' (duration: 429.363573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.071874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:37.642381Z","time spent":"429.484235ms","remote":"127.0.0.1:50724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-26T08:17:38.071737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.180483ms","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-26T08:17:38.071994Z","caller":"traceutil/trace.go:171","msg":"trace[1749169652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"700.49449ms","start":"2026-05-26T08:17:37.371491Z","end":"2026-05-26T08:17:38.071986Z","steps":["trace[1749169652] 'agreement among raft nodes before linearized reading' (duration: 700.131483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.072037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:37.371462Z","time spent":"700.564831ms","remote":"127.0.0.1:38962","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-26T08:17:38.07204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.785936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2723"} {"level":"info","ts":"2026-05-26T08:17:38.072077Z","caller":"traceutil/trace.go:171","msg":"trace[1075672268] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1311; }","duration":"111.854287ms","start":"2026-05-26T08:17:37.960216Z","end":"2026-05-26T08:17:38.07207Z","steps":["trace[1075672268] 'agreement among raft nodes before linearized reading' (duration: 111.675784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.071895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135406034s","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-05-26T08:17:38.072167Z","caller":"traceutil/trace.go:171","msg":"trace[1347845378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"1.135779663s","start":"2026-05-26T08:17:36.936375Z","end":"2026-05-26T08:17:38.072155Z","steps":["trace[1347845378] 'agreement among raft nodes before linearized reading' (duration: 1.135206601s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.07217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.860869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T08:17:38.07222Z","caller":"traceutil/trace.go:171","msg":"trace[1575754360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"983.944591ms","start":"2026-05-26T08:17:37.088265Z","end":"2026-05-26T08:17:38.07221Z","steps":["trace[1575754360] 'agreement among raft nodes before linearized reading' (duration: 983.87384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.07223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.936354Z","time spent":"1.135844544s","remote":"127.0.0.1:38962","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-05-26T08:17:38.072253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:37.088246Z","time spent":"984.001222ms","remote":"127.0.0.1:38736","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-26T08:17:38.072287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135832053s","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-05-26T08:17:38.072315Z","caller":"traceutil/trace.go:171","msg":"trace[436893110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"1.135898355s","start":"2026-05-26T08:17:36.93641Z","end":"2026-05-26T08:17:38.072308Z","steps":["trace[436893110] 'agreement among raft nodes before linearized reading' (duration: 1.135828583s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.072337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:36.936382Z","time spent":"1.135950605s","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T08:17:38.072243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.255517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-26T08:17:38.072402Z","caller":"traceutil/trace.go:171","msg":"trace[1011153828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"750.494451ms","start":"2026-05-26T08:17:37.321899Z","end":"2026-05-26T08:17:38.072394Z","steps":["trace[1011153828] 'agreement among raft nodes before linearized reading' (duration: 750.022391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:38.072596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:37.321882Z","time spent":"750.702116ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T08:17:44.394629Z","caller":"traceutil/trace.go:171","msg":"trace[1782699251] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"183.04816ms","start":"2026-05-26T08:17:44.211557Z","end":"2026-05-26T08:17:44.394605Z","steps":["trace[1782699251] 'process raft request' (duration: 182.993079ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:44.394825Z","caller":"traceutil/trace.go:171","msg":"trace[2021162666] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"183.299005ms","start":"2026-05-26T08:17:44.2115Z","end":"2026-05-26T08:17:44.394799Z","steps":["trace[2021162666] 'process raft request' (duration: 182.863296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:44.674134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.324281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:44.674233Z","caller":"traceutil/trace.go:171","msg":"trace[1395360304] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"247.001809ms","start":"2026-05-26T08:17:44.427213Z","end":"2026-05-26T08:17:44.674215Z","steps":["trace[1395360304] 'process raft request' (duration: 93.533955ms)","trace[1395360304] 'compare' (duration: 153.141617ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:46.964719Z","caller":"traceutil/trace.go:171","msg":"trace[622758918] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"126.794345ms","start":"2026-05-26T08:17:46.837905Z","end":"2026-05-26T08:17:46.964699Z","steps":["trace[622758918] 'process raft request' (duration: 126.652252ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:51.160709Z","caller":"traceutil/trace.go:171","msg":"trace[993747436] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"177.623123ms","start":"2026-05-26T08:17:50.983058Z","end":"2026-05-26T08:17:51.160681Z","steps":["trace[993747436] 'process raft request' (duration: 177.49027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:54.752153Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558138145641017899,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T08:17:54.753816Z","caller":"traceutil/trace.go:171","msg":"trace[1140092040] linearizableReadLoop","detail":"{readStateIndex:1475; appliedIndex:1474; }","duration":"501.710339ms","start":"2026-05-26T08:17:54.252077Z","end":"2026-05-26T08:17:54.753787Z","steps":["trace[1140092040] 'read index received' (duration: 501.466494ms)","trace[1140092040] 'applied index is now lower than readState.Index' (duration: 242.735µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:54.753947Z","caller":"traceutil/trace.go:171","msg":"trace[336217317] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"539.727493ms","start":"2026-05-26T08:17:54.214182Z","end":"2026-05-26T08:17:54.753909Z","steps":["trace[336217317] 'process raft request' (duration: 539.436317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:54.754151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.214152Z","time spent":"539.913577ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T08:17:54.754147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.454476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-26T08:17:54.754218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.358383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-26T08:17:54.754211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.107946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-26T08:17:54.75424Z","caller":"traceutil/trace.go:171","msg":"trace[1140150981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1422; }","duration":"488.593869ms","start":"2026-05-26T08:17:54.265626Z","end":"2026-05-26T08:17:54.75422Z","steps":["trace[1140150981] 'agreement among raft nodes before linearized reading' (duration: 488.341144ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:54.754266Z","caller":"traceutil/trace.go:171","msg":"trace[588769649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1422; }","duration":"502.215519ms","start":"2026-05-26T08:17:54.252035Z","end":"2026-05-26T08:17:54.754251Z","steps":["trace[588769649] 'agreement among raft nodes before linearized reading' (duration: 501.886363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:54.754292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.265607Z","time spent":"488.67708ms","remote":"127.0.0.1:38962","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-05-26T08:17:54.754323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.252016Z","time spent":"502.294641ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T08:17:54.754342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.847672ms","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-05-26T08:17:54.754397Z","caller":"traceutil/trace.go:171","msg":"trace[1661867203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1422; }","duration":"315.932124ms","start":"2026-05-26T08:17:54.43845Z","end":"2026-05-26T08:17:54.754382Z","steps":["trace[1661867203] 'agreement among raft nodes before linearized reading' (duration: 315.74891ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:54.754252Z","caller":"traceutil/trace.go:171","msg":"trace[2052100327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1422; }","duration":"315.412964ms","start":"2026-05-26T08:17:54.438828Z","end":"2026-05-26T08:17:54.754241Z","steps":["trace[2052100327] 'agreement among raft nodes before linearized reading' (duration: 315.319892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:54.754449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.43843Z","time spent":"316.007125ms","remote":"127.0.0.1:38962","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-05-26T08:17:54.754486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.43882Z","time spent":"315.618698ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T08:17:55.30225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.35449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:55.302337Z","caller":"traceutil/trace.go:171","msg":"trace[1422940145] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"543.62808ms","start":"2026-05-26T08:17:54.758694Z","end":"2026-05-26T08:17:55.302322Z","steps":["trace[1422940145] 'process raft request' (duration: 209.130487ms)","trace[1422940145] 'compare' (duration: 334.050363ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T08:17:55.302536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.758667Z","time spent":"543.845355ms","remote":"127.0.0.1:38962","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-05-26T08:17:55.324895Z","caller":"traceutil/trace.go:171","msg":"trace[1218407383] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"563.450784ms","start":"2026-05-26T08:17:54.761412Z","end":"2026-05-26T08:17:55.324862Z","steps":["trace[1218407383] 'process raft request' (duration: 563.396033ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:55.324952Z","caller":"traceutil/trace.go:171","msg":"trace[755988936] linearizableReadLoop","detail":"{readStateIndex:1480; appliedIndex:1480; }","duration":"342.771827ms","start":"2026-05-26T08:17:54.982141Z","end":"2026-05-26T08:17:55.324913Z","steps":["trace[755988936] 'read index received' (duration: 342.756027ms)","trace[755988936] 'applied index is now lower than readState.Index' (duration: 11.82µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:55.324996Z","caller":"traceutil/trace.go:171","msg":"trace[716177779] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"563.834681ms","start":"2026-05-26T08:17:54.761118Z","end":"2026-05-26T08:17:55.324952Z","steps":["trace[716177779] 'process raft request' (duration: 563.597746ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:55.325016Z","caller":"traceutil/trace.go:171","msg":"trace[1732368378] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"564.085885ms","start":"2026-05-26T08:17:54.76089Z","end":"2026-05-26T08:17:55.324976Z","steps":["trace[1732368378] 'process raft request' (duration: 563.668157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:55.325148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.761091Z","time spent":"563.978914ms","remote":"127.0.0.1:38962","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-26T08:17:55.325188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.769149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T08:17:55.325241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.760869Z","time spent":"564.222298ms","remote":"127.0.0.1:38962","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-05-26T08:17:55.325261Z","caller":"traceutil/trace.go:171","msg":"trace[1944897622] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"564.056085ms","start":"2026-05-26T08:17:54.761169Z","end":"2026-05-26T08:17:55.325225Z","steps":["trace[1944897622] 'process raft request' (duration: 563.597826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:55.325364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.221525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T08:17:55.325373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.761135Z","time spent":"564.182028ms","remote":"127.0.0.1:38962","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-05-26T08:17:55.325419Z","caller":"traceutil/trace.go:171","msg":"trace[1089368867] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1427; }","duration":"343.289277ms","start":"2026-05-26T08:17:54.982096Z","end":"2026-05-26T08:17:55.325385Z","steps":["trace[1089368867] 'agreement among raft nodes before linearized reading' (duration: 343.246996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:55.325362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.761389Z","time spent":"563.607157ms","remote":"127.0.0.1:38962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T08:17:55.325285Z","caller":"traceutil/trace.go:171","msg":"trace[661716846] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1427; }","duration":"270.909041ms","start":"2026-05-26T08:17:55.054333Z","end":"2026-05-26T08:17:55.325242Z","steps":["trace[661716846] 'agreement among raft nodes before linearized reading' (duration: 270.706297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:55.32545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T08:17:54.982079Z","time spent":"343.364648ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-05-26T08:17:55.325632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.092715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-26T08:17:55.325698Z","caller":"traceutil/trace.go:171","msg":"trace[1065860167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1427; }","duration":"152.181478ms","start":"2026-05-26T08:17:55.173496Z","end":"2026-05-26T08:17:55.325677Z","steps":["trace[1065860167] 'agreement among raft nodes before linearized reading' (duration: 152.000214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T08:17:55.523716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.571092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T08:17:55.5239Z","caller":"traceutil/trace.go:171","msg":"trace[1382020980] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"192.799773ms","start":"2026-05-26T08:17:55.331082Z","end":"2026-05-26T08:17:55.523882Z","steps":["trace[1382020980] 'process raft request' (duration: 77.953746ms)","trace[1382020980] 'compare' (duration: 114.432749ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T08:17:55.524112Z","caller":"traceutil/trace.go:171","msg":"trace[993060734] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"190.986676ms","start":"2026-05-26T08:17:55.33311Z","end":"2026-05-26T08:17:55.524096Z","steps":["trace[993060734] 'process raft request' (duration: 190.917345ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T08:17:55.524262Z","caller":"traceutil/trace.go:171","msg":"trace[876355037] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"192.584248ms","start":"2026-05-26T08:17:55.331659Z","end":"2026-05-26T08:17:55.524243Z","steps":["trace[876355037] 'process raft request' (duration: 192.17303ms)"],"step_count":1}