{"level":"warn","ts":"2026-07-17T14:24:10.923077Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T14:24:10.923185Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.159: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.159:2380","--initial-cluster=instance=https://199.19.213.159:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.159:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.159:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-17T14:24:10.923252Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T14:24:10.923264Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.159:2380"]} {"level":"info","ts":"2026-07-17T14:24:10.923281Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T14:24:10.92396Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.159:2379"]} {"level":"info","ts":"2026-07-17T14:24:10.924045Z","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.159:2380"],"listen-peer-urls":["https://199.19.213.159:2380"],"advertise-client-urls":["https://199.19.213.159:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.159:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.159:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-17T14:24:10.930519Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.277635ms"} {"level":"info","ts":"2026-07-17T14:24:10.944321Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"63cd833aa17a09c7","cluster-id":"27437233b92849be"} {"level":"info","ts":"2026-07-17T14:24:10.944432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T14:24:10.944469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 became follower at term 0"} {"level":"info","ts":"2026-07-17T14:24:10.944483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 63cd833aa17a09c7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T14:24:10.944492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 became follower at term 1"} {"level":"info","ts":"2026-07-17T14:24:10.944544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 switched to configuration voters=(7191548467821021639)"} {"level":"warn","ts":"2026-07-17T14:24:10.953762Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T14:24:10.955597Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T14:24:10.956659Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-17T14:24:10.959441Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"63cd833aa17a09c7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T14:24:10.959622Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T14:24:10.959723Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T14:24:10.959734Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T14:24:10.959782Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"63cd833aa17a09c7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T14:24:10.964175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 switched to configuration voters=(7191548467821021639)"} {"level":"info","ts":"2026-07-17T14:24:10.965052Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"27437233b92849be","local-member-id":"63cd833aa17a09c7","added-peer-id":"63cd833aa17a09c7","added-peer-peer-urls":["https://199.19.213.159:2380"]} {"level":"info","ts":"2026-07-17T14:24:10.966444Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T14:24:10.966567Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.159:2380"} {"level":"info","ts":"2026-07-17T14:24:10.966612Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.159:2380"} {"level":"info","ts":"2026-07-17T14:24:10.967354Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"63cd833aa17a09c7","initial-advertise-peer-urls":["https://199.19.213.159:2380"],"listen-peer-urls":["https://199.19.213.159:2380"],"advertise-client-urls":["https://199.19.213.159:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.159:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T14:24:10.967404Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T14:24:11.745161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T14:24:11.745215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T14:24:11.745267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 received MsgPreVoteResp from 63cd833aa17a09c7 at term 1"} {"level":"info","ts":"2026-07-17T14:24:11.745292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 became candidate at term 2"} {"level":"info","ts":"2026-07-17T14:24:11.745307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 received MsgVoteResp from 63cd833aa17a09c7 at term 2"} {"level":"info","ts":"2026-07-17T14:24:11.745326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"63cd833aa17a09c7 became leader at term 2"} {"level":"info","ts":"2026-07-17T14:24:11.745342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 63cd833aa17a09c7 elected leader 63cd833aa17a09c7 at term 2"} {"level":"info","ts":"2026-07-17T14:24:11.746389Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"63cd833aa17a09c7","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.159:2379]}","request-path":"/0/members/63cd833aa17a09c7/attributes","cluster-id":"27437233b92849be","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T14:24:11.746431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T14:24:11.746398Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T14:24:11.746456Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T14:24:11.747379Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"27437233b92849be","local-member-id":"63cd833aa17a09c7","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T14:24:11.747451Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T14:24:11.747478Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T14:24:11.748959Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T14:24:11.749065Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T14:24:11.749506Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T14:24:11.763364Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.159:2379"} {"level":"warn","ts":"2026-07-17T14:24:17.282388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:17.782859Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:17.810027Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.297509123s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T14:24:17.81043Z","caller":"traceutil/trace.go:171","msg":"trace[2120880856] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"1.297964965s","start":"2026-07-17T14:24:16.512435Z","end":"2026-07-17T14:24:17.8104Z","steps":["trace[2120880856] 'process raft request' (duration: 1.297807231s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.810989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:16.512386Z","time spent":"1.298123658s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:17.823093Z","caller":"traceutil/trace.go:171","msg":"trace[891804251] linearizableReadLoop","detail":"{readStateIndex:225; appliedIndex:223; }","duration":"1.041202643s","start":"2026-07-17T14:24:16.781869Z","end":"2026-07-17T14:24:17.823072Z","steps":["trace[891804251] 'read index received' (duration: 1.028308873s)","trace[891804251] 'applied index is now lower than readState.Index' (duration: 12.89274ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:17.823201Z","caller":"traceutil/trace.go:171","msg":"trace[1159591055] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"435.138371ms","start":"2026-07-17T14:24:17.388028Z","end":"2026-07-17T14:24:17.823166Z","steps":["trace[1159591055] 'process raft request' (duration: 434.943106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:17.388006Z","time spent":"435.259474ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T14:24:17.823352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.830127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-17T14:24:17.823311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.432608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:24:17.823425Z","caller":"traceutil/trace.go:171","msg":"trace[1640127506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:219; }","duration":"723.598522ms","start":"2026-07-17T14:24:17.099816Z","end":"2026-07-17T14:24:17.823414Z","steps":["trace[1640127506] 'agreement among raft nodes before linearized reading' (duration: 723.417718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:17.099792Z","time spent":"723.674434ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T14:24:17.823534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.525628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T14:24:17.823386Z","caller":"traceutil/trace.go:171","msg":"trace[73884047] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:219; }","duration":"304.900519ms","start":"2026-07-17T14:24:17.518474Z","end":"2026-07-17T14:24:17.823375Z","steps":["trace[73884047] 'agreement among raft nodes before linearized reading' (duration: 304.832817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.862812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-17T14:24:17.82356Z","caller":"traceutil/trace.go:171","msg":"trace[341965677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:219; }","duration":"704.584639ms","start":"2026-07-17T14:24:17.118966Z","end":"2026-07-17T14:24:17.82355Z","steps":["trace[341965677] 'agreement among raft nodes before linearized reading' (duration: 704.553389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:17.518452Z","time spent":"305.108204ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:24:17.823581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:17.118941Z","time spent":"704.636641ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T14:24:17.823589Z","caller":"traceutil/trace.go:171","msg":"trace[1614345793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:219; }","duration":"703.989755ms","start":"2026-07-17T14:24:17.119582Z","end":"2026-07-17T14:24:17.823572Z","steps":["trace[1614345793] 'agreement among raft nodes before linearized reading' (duration: 703.841521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:17.119568Z","time spent":"704.043887ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:17.823829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041386668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-07-17T14:24:17.823932Z","caller":"traceutil/trace.go:171","msg":"trace[1009910779] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:219; }","duration":"1.042091926s","start":"2026-07-17T14:24:16.781811Z","end":"2026-07-17T14:24:17.823903Z","steps":["trace[1009910779] 'agreement among raft nodes before linearized reading' (duration: 1.041376948s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:17.823989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:16.781783Z","time spent":"1.042185189s","remote":"127.0.0.1:33008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3731,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-17T14:24:19.570061Z","caller":"traceutil/trace.go:171","msg":"trace[1123885507] transaction","detail":"{read_only:false; number_of_response:0; response_revision:276; }","duration":"117.681463ms","start":"2026-07-17T14:24:19.452348Z","end":"2026-07-17T14:24:19.57003Z","steps":["trace[1123885507] 'process raft request' (duration: 117.498689ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.57012Z","caller":"traceutil/trace.go:171","msg":"trace[138544613] transaction","detail":"{read_only:false; number_of_response:0; response_revision:276; }","duration":"117.53642ms","start":"2026-07-17T14:24:19.452566Z","end":"2026-07-17T14:24:19.570102Z","steps":["trace[138544613] 'process raft request' (duration: 117.396277ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.570056Z","caller":"traceutil/trace.go:171","msg":"trace[1147516083] transaction","detail":"{read_only:false; number_of_response:0; response_revision:276; }","duration":"117.636653ms","start":"2026-07-17T14:24:19.452398Z","end":"2026-07-17T14:24:19.570035Z","steps":["trace[1147516083] 'process raft request' (duration: 117.53305ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.570961Z","caller":"traceutil/trace.go:171","msg":"trace[1415196903] transaction","detail":"{read_only:false; number_of_response:0; response_revision:276; }","duration":"117.301715ms","start":"2026-07-17T14:24:19.452748Z","end":"2026-07-17T14:24:19.570049Z","steps":["trace[1415196903] 'process raft request' (duration: 117.232833ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.728078Z","caller":"traceutil/trace.go:171","msg":"trace[286857541] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"204.652825ms","start":"2026-07-17T14:24:19.523408Z","end":"2026-07-17T14:24:19.728061Z","steps":["trace[286857541] 'process raft request' (duration: 204.46192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:19.728225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.409692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-07-17T14:24:19.728288Z","caller":"traceutil/trace.go:171","msg":"trace[1532661686] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:277; }","duration":"209.523575ms","start":"2026-07-17T14:24:19.518749Z","end":"2026-07-17T14:24:19.728272Z","steps":["trace[1532661686] 'agreement among raft nodes before linearized reading' (duration: 209.385561ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.728382Z","caller":"traceutil/trace.go:171","msg":"trace[620873723] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:290; }","duration":"158.018486ms","start":"2026-07-17T14:24:19.570004Z","end":"2026-07-17T14:24:19.728022Z","steps":["trace[620873723] 'read index received' (duration: 157.751119ms)","trace[620873723] 'applied index is now lower than readState.Index' (duration: 266.357µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:19.730123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.849947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6755"} {"level":"info","ts":"2026-07-17T14:24:19.730204Z","caller":"traceutil/trace.go:171","msg":"trace[335100904] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:278; }","duration":"158.997451ms","start":"2026-07-17T14:24:19.571189Z","end":"2026-07-17T14:24:19.730186Z","steps":["trace[335100904] 'agreement among raft nodes before linearized reading' (duration: 158.822657ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:19.730415Z","caller":"traceutil/trace.go:171","msg":"trace[1113095956] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"157.164445ms","start":"2026-07-17T14:24:19.57322Z","end":"2026-07-17T14:24:19.730385Z","steps":["trace[1113095956] 'process raft request' (duration: 156.679243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:19.730478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.204786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-07-17T14:24:19.730511Z","caller":"traceutil/trace.go:171","msg":"trace[338958130] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:278; }","duration":"159.269708ms","start":"2026-07-17T14:24:19.571233Z","end":"2026-07-17T14:24:19.730503Z","steps":["trace[338958130] 'agreement among raft nodes before linearized reading' (duration: 159.206676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:19.730197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.18609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-07-17T14:24:19.731709Z","caller":"traceutil/trace.go:171","msg":"trace[730146711] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:278; }","duration":"159.716508ms","start":"2026-07-17T14:24:19.571969Z","end":"2026-07-17T14:24:19.731686Z","steps":["trace[730146711] 'agreement among raft nodes before linearized reading' (duration: 158.157969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:19.732215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.19674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-07-17T14:24:19.732272Z","caller":"traceutil/trace.go:171","msg":"trace[1760833603] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:278; }","duration":"160.857367ms","start":"2026-07-17T14:24:19.571402Z","end":"2026-07-17T14:24:19.732259Z","steps":["trace[1760833603] 'agreement among raft nodes before linearized reading' (duration: 160.747555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:23.167853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:23.668072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:24.169191Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:24.402069Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.780290091s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T14:24:24.402489Z","caller":"traceutil/trace.go:171","msg":"trace[1042996122] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"1.780792932s","start":"2026-07-17T14:24:22.621671Z","end":"2026-07-17T14:24:24.402464Z","steps":["trace[1042996122] 'process raft request' (duration: 1.780650169s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.402796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.621646Z","time spent":"1.780912146s","remote":"127.0.0.1:32940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:24.403457Z","caller":"traceutil/trace.go:171","msg":"trace[667395206] linearizableReadLoop","detail":"{readStateIndex:341; appliedIndex:339; }","duration":"1.735967557s","start":"2026-07-17T14:24:22.667473Z","end":"2026-07-17T14:24:24.403441Z","steps":["trace[667395206] 'read index received' (duration: 1.734910771s)","trace[667395206] 'applied index is now lower than readState.Index' (duration: 1.056126ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:24.403632Z","caller":"traceutil/trace.go:171","msg":"trace[1711744356] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"1.10071528s","start":"2026-07-17T14:24:23.302909Z","end":"2026-07-17T14:24:24.403624Z","steps":["trace[1711744356] 'process raft request' (duration: 1.100450383s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.403724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:23.302882Z","time spent":"1.100773322s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:24:24.403945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73646605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-17T14:24:24.403972Z","caller":"traceutil/trace.go:171","msg":"trace[427529511] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:327; }","duration":"1.736516911s","start":"2026-07-17T14:24:22.667447Z","end":"2026-07-17T14:24:24.403964Z","steps":["trace[427529511] 'agreement among raft nodes before linearized reading' (duration: 1.73646596s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.667433Z","time spent":"1.736563812s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687174744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-17T14:24:24.404173Z","caller":"traceutil/trace.go:171","msg":"trace[272660662] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:327; }","duration":"1.687229644s","start":"2026-07-17T14:24:22.716937Z","end":"2026-07-17T14:24:24.404167Z","steps":["trace[272660662] 'agreement among raft nodes before linearized reading' (duration: 1.687182523s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.716922Z","time spent":"1.687264246s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.682449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T14:24:24.404307Z","caller":"traceutil/trace.go:171","msg":"trace[1948029105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:327; }","duration":"507.768101ms","start":"2026-07-17T14:24:23.896525Z","end":"2026-07-17T14:24:24.404293Z","steps":["trace[1948029105] 'agreement among raft nodes before linearized reading' (duration: 507.672599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:23.896504Z","time spent":"507.828864ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.106605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T14:24:24.404405Z","caller":"traceutil/trace.go:171","msg":"trace[1885061326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:327; }","duration":"521.185147ms","start":"2026-07-17T14:24:23.883202Z","end":"2026-07-17T14:24:24.404387Z","steps":["trace[1885061326] 'agreement among raft nodes before linearized reading' (duration: 521.133825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:23.883176Z","time spent":"521.244138ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.488497631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-17T14:24:24.404497Z","caller":"traceutil/trace.go:171","msg":"trace[489937268] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:327; }","duration":"1.488542892s","start":"2026-07-17T14:24:22.91595Z","end":"2026-07-17T14:24:24.404493Z","steps":["trace[489937268] 'agreement among raft nodes before linearized reading' (duration: 1.488515542s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.915911Z","time spent":"1.488597694s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.519658336s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-17T14:24:24.404604Z","caller":"traceutil/trace.go:171","msg":"trace[115301457] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:327; }","duration":"1.519676637s","start":"2026-07-17T14:24:22.884922Z","end":"2026-07-17T14:24:24.404599Z","steps":["trace[115301457] 'agreement among raft nodes before linearized reading' (duration: 1.519621515s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.884905Z","time spent":"1.519711787s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.039063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:24:24.404667Z","caller":"traceutil/trace.go:171","msg":"trace[889579603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:327; }","duration":"474.091114ms","start":"2026-07-17T14:24:23.930566Z","end":"2026-07-17T14:24:24.404658Z","steps":["trace[889579603] 'agreement among raft nodes before linearized reading' (duration: 474.037853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:23.930555Z","time spent":"474.132035ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.570651404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-17T14:24:24.404725Z","caller":"traceutil/trace.go:171","msg":"trace[522666795] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:327; }","duration":"1.570701306s","start":"2026-07-17T14:24:22.834019Z","end":"2026-07-17T14:24:24.40472Z","steps":["trace[522666795] 'agreement among raft nodes before linearized reading' (duration: 1.570671825s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.833996Z","time spent":"1.570741317s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.267649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T14:24:24.404831Z","caller":"traceutil/trace.go:171","msg":"trace[12038186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:327; }","duration":"474.306449ms","start":"2026-07-17T14:24:23.930517Z","end":"2026-07-17T14:24:24.404823Z","steps":["trace[12038186] 'agreement among raft nodes before linearized reading' (duration: 474.264498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:23.930506Z","time spent":"474.34392ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:24.404854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.638213296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-07-17T14:24:24.404923Z","caller":"traceutil/trace.go:171","msg":"trace[1440085155] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:327; }","duration":"1.638283878s","start":"2026-07-17T14:24:22.766632Z","end":"2026-07-17T14:24:24.404916Z","steps":["trace[1440085155] 'agreement among raft nodes before linearized reading' (duration: 1.638196875s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.404945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.766585Z","time spent":"1.638352329s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-07-17T14:24:24.405011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.664159181s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-07-17T14:24:24.405083Z","caller":"traceutil/trace.go:171","msg":"trace[882553770] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:327; }","duration":"1.664286953s","start":"2026-07-17T14:24:22.740779Z","end":"2026-07-17T14:24:24.405066Z","steps":["trace[882553770] 'agreement among raft nodes before linearized reading' (duration: 1.66413859s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:24.405296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:22.740763Z","time spent":"1.664351835s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":207,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-07-17T14:24:25.930442Z","caller":"traceutil/trace.go:171","msg":"trace[240323933] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"201.51853ms","start":"2026-07-17T14:24:25.7289Z","end":"2026-07-17T14:24:25.930419Z","steps":["trace[240323933] 'process raft request' (duration: 201.372066ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:29.555837Z","caller":"traceutil/trace.go:171","msg":"trace[2038367779] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"547.515499ms","start":"2026-07-17T14:24:29.008297Z","end":"2026-07-17T14:24:29.555813Z","steps":["trace[2038367779] 'process raft request' (duration: 547.381796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:29.555984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:29.008285Z","time spent":"547.629052ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:24:35.040641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303856,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T14:24:35.451739Z","caller":"traceutil/trace.go:171","msg":"trace[1746045839] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:403; }","duration":"911.513677ms","start":"2026-07-17T14:24:34.540202Z","end":"2026-07-17T14:24:35.451715Z","steps":["trace[1746045839] 'read index received' (duration: 911.320212ms)","trace[1746045839] 'applied index is now lower than readState.Index' (duration: 192.625µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:35.45188Z","caller":"traceutil/trace.go:171","msg":"trace[1220844977] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"927.19779ms","start":"2026-07-17T14:24:34.524645Z","end":"2026-07-17T14:24:35.451843Z","steps":["trace[1220844977] 'process raft request' (duration: 926.928493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:35.45197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.744532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-17T14:24:35.451972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.605444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T14:24:35.452011Z","caller":"traceutil/trace.go:171","msg":"trace[1397751906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:387; }","duration":"911.840605ms","start":"2026-07-17T14:24:34.540157Z","end":"2026-07-17T14:24:35.451998Z","steps":["trace[1397751906] 'agreement among raft nodes before linearized reading' (duration: 911.677771ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:35.452025Z","caller":"traceutil/trace.go:171","msg":"trace[305082579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:387; }","duration":"910.718127ms","start":"2026-07-17T14:24:34.541291Z","end":"2026-07-17T14:24:35.452009Z","steps":["trace[305082579] 'agreement among raft nodes before linearized reading' (duration: 910.613154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:35.452046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:34.540134Z","time spent":"911.903497ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T14:24:35.45204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:34.524617Z","time spent":"927.340973ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:24:35.452059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:34.541256Z","time spent":"910.795369ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:24:35.452264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.621205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-17T14:24:35.452309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.355398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T14:24:35.45233Z","caller":"traceutil/trace.go:171","msg":"trace[619435544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:387; }","duration":"910.691306ms","start":"2026-07-17T14:24:34.541618Z","end":"2026-07-17T14:24:35.452309Z","steps":["trace[619435544] 'agreement among raft nodes before linearized reading' (duration: 910.583514ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:35.452347Z","caller":"traceutil/trace.go:171","msg":"trace[1494955170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:387; }","duration":"910.40937ms","start":"2026-07-17T14:24:34.541926Z","end":"2026-07-17T14:24:35.452335Z","steps":["trace[1494955170] 'agreement among raft nodes before linearized reading' (duration: 910.319238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:35.452371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:34.541598Z","time spent":"910.765029ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:35.452384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:34.541921Z","time spent":"910.451991ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:36.055578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082303860,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T14:24:36.33688Z","caller":"traceutil/trace.go:171","msg":"trace[552208606] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"877.866623ms","start":"2026-07-17T14:24:35.458987Z","end":"2026-07-17T14:24:36.336854Z","steps":["trace[552208606] 'process raft request' (duration: 852.409546ms)","trace[552208606] 'compare' (duration: 25.348224ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:36.337837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:35.458971Z","time spent":"877.997115ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:36.368782Z","caller":"traceutil/trace.go:171","msg":"trace[1311093455] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"909.651427ms","start":"2026-07-17T14:24:35.459112Z","end":"2026-07-17T14:24:36.368763Z","steps":["trace[1311093455] 'process raft request' (duration: 909.483643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:36.368895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:35.459086Z","time spent":"909.75393ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:36.369074Z","caller":"traceutil/trace.go:171","msg":"trace[1446415199] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:404; }","duration":"813.786262ms","start":"2026-07-17T14:24:35.555247Z","end":"2026-07-17T14:24:36.369033Z","steps":["trace[1446415199] 'read index received' (duration: 756.15365ms)","trace[1446415199] 'applied index is now lower than readState.Index' (duration: 57.631962ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:36.369142Z","caller":"traceutil/trace.go:171","msg":"trace[1006922543] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"908.812067ms","start":"2026-07-17T14:24:35.460278Z","end":"2026-07-17T14:24:36.36909Z","steps":["trace[1006922543] 'process raft request' (duration: 908.452658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:36.369272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:35.460264Z","time spent":"908.973002ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:36.369162Z","caller":"traceutil/trace.go:171","msg":"trace[72227346] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"908.205643ms","start":"2026-07-17T14:24:35.460933Z","end":"2026-07-17T14:24:36.369139Z","steps":["trace[72227346] 'process raft request' (duration: 908.020437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:36.369193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.931695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.159\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-17T14:24:36.369455Z","caller":"traceutil/trace.go:171","msg":"trace[1962868441] range","detail":"{range_begin:/registry/masterleases/199.19.213.159; range_end:; response_count:1; response_revision:391; }","duration":"814.253363ms","start":"2026-07-17T14:24:35.555188Z","end":"2026-07-17T14:24:36.369441Z","steps":["trace[1962868441] 'agreement among raft nodes before linearized reading' (duration: 813.947606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:36.369502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:35.555175Z","time spent":"814.311224ms","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.159\" "} {"level":"warn","ts":"2026-07-17T14:24:36.369474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:35.460922Z","time spent":"908.442349ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:42.328437Z","caller":"traceutil/trace.go:171","msg":"trace[2053189602] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"191.623773ms","start":"2026-07-17T14:24:42.13679Z","end":"2026-07-17T14:24:42.328414Z","steps":["trace[2053189602] 'process raft request' (duration: 154.39256ms)","trace[2053189602] 'compare' (duration: 36.69743ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:44.70846Z","caller":"traceutil/trace.go:171","msg":"trace[1537069048] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"216.693254ms","start":"2026-07-17T14:24:44.491727Z","end":"2026-07-17T14:24:44.70842Z","steps":["trace[1537069048] 'process raft request' (duration: 154.019033ms)","trace[1537069048] 'compare' (duration: 62.415704ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:44.708822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.598815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:24:44.708894Z","caller":"traceutil/trace.go:171","msg":"trace[162602724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:438; }","duration":"195.681957ms","start":"2026-07-17T14:24:44.513196Z","end":"2026-07-17T14:24:44.708878Z","steps":["trace[162602724] 'agreement among raft nodes before linearized reading' (duration: 195.549114ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:44.709696Z","caller":"traceutil/trace.go:171","msg":"trace[1445582107] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:456; }","duration":"195.101792ms","start":"2026-07-17T14:24:44.513208Z","end":"2026-07-17T14:24:44.70831Z","steps":["trace[1445582107] 'read index received' (duration: 132.492573ms)","trace[1445582107] 'applied index is now lower than readState.Index' (duration: 62.608349ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:44.709956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.629321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T14:24:44.709997Z","caller":"traceutil/trace.go:171","msg":"trace[548736897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:438; }","duration":"129.702533ms","start":"2026-07-17T14:24:44.580284Z","end":"2026-07-17T14:24:44.709986Z","steps":["trace[548736897] 'agreement among raft nodes before linearized reading' (duration: 129.565329ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:44.977199Z","caller":"traceutil/trace.go:171","msg":"trace[1157878892] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"263.18503ms","start":"2026-07-17T14:24:44.71398Z","end":"2026-07-17T14:24:44.977165Z","steps":["trace[1157878892] 'process raft request' (duration: 181.80909ms)","trace[1157878892] 'compare' (duration: 81.247547ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:46.129507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:45.57209Z","time spent":"557.413333ms","remote":"127.0.0.1:32844","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-17T14:24:46.919802Z","caller":"traceutil/trace.go:171","msg":"trace[431292879] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"1.127366087s","start":"2026-07-17T14:24:45.792355Z","end":"2026-07-17T14:24:46.919721Z","steps":["trace[431292879] 'process raft request' (duration: 1.08684457s)","trace[431292879] 'compare' (duration: 40.347813ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:46.92035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:45.792329Z","time spent":"1.127930101s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:46.984311Z","caller":"traceutil/trace.go:171","msg":"trace[283392199] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:460; }","duration":"513.820674ms","start":"2026-07-17T14:24:46.470445Z","end":"2026-07-17T14:24:46.984266Z","steps":["trace[283392199] 'read index received' (duration: 408.769157ms)","trace[283392199] 'applied index is now lower than readState.Index' (duration: 105.050687ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:46.984351Z","caller":"traceutil/trace.go:171","msg":"trace[761195795] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"853.831305ms","start":"2026-07-17T14:24:46.130481Z","end":"2026-07-17T14:24:46.984312Z","steps":["trace[761195795] 'process raft request' (duration: 853.590419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:46.984484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.613086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-17T14:24:46.984498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.045449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:24:46.984527Z","caller":"traceutil/trace.go:171","msg":"trace[1629267084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:442; }","duration":"493.692538ms","start":"2026-07-17T14:24:46.490824Z","end":"2026-07-17T14:24:46.984516Z","steps":["trace[1629267084] 'agreement among raft nodes before linearized reading' (duration: 493.583895ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:46.98455Z","caller":"traceutil/trace.go:171","msg":"trace[1362321393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:442; }","duration":"514.0979ms","start":"2026-07-17T14:24:46.470435Z","end":"2026-07-17T14:24:46.984533Z","steps":["trace[1362321393] 'agreement among raft nodes before linearized reading' (duration: 513.961087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:46.98456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:46.490808Z","time spent":"493.743879ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T14:24:46.984584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:46.470394Z","time spent":"514.183013ms","remote":"127.0.0.1:32786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T14:24:46.984594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.640131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-17T14:24:46.984594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.064134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:24:46.984631Z","caller":"traceutil/trace.go:171","msg":"trace[1762190054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:442; }","duration":"272.718193ms","start":"2026-07-17T14:24:46.711902Z","end":"2026-07-17T14:24:46.98462Z","steps":["trace[1762190054] 'agreement among raft nodes before linearized reading' (duration: 272.62407ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:46.984631Z","caller":"traceutil/trace.go:171","msg":"trace[1793327257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:442; }","duration":"181.134226ms","start":"2026-07-17T14:24:46.80349Z","end":"2026-07-17T14:24:46.984624Z","steps":["trace[1793327257] 'agreement among raft nodes before linearized reading' (duration: 181.038193ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:46.984736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:46.130463Z","time spent":"853.955328ms","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:55.269915Z","caller":"traceutil/trace.go:171","msg":"trace[1473045415] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"217.378678ms","start":"2026-07-17T14:24:55.052499Z","end":"2026-07-17T14:24:55.269878Z","steps":["trace[1473045415] 'read index received' (duration: 217.362217ms)","trace[1473045415] 'applied index is now lower than readState.Index' (duration: 13.841µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:55.27005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.549883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-17T14:24:55.270119Z","caller":"traceutil/trace.go:171","msg":"trace[1109663789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:494; }","duration":"217.623194ms","start":"2026-07-17T14:24:55.052483Z","end":"2026-07-17T14:24:55.270106Z","steps":["trace[1109663789] 'agreement among raft nodes before linearized reading' (duration: 217.521332ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:55.270192Z","caller":"traceutil/trace.go:171","msg":"trace[260962993] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"218.575708ms","start":"2026-07-17T14:24:55.051302Z","end":"2026-07-17T14:24:55.269878Z","steps":["trace[260962993] 'process raft request' (duration: 218.436164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:55.770566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:56.271686Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:56.772533Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:24:57.140451Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.870225241s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T14:24:57.14094Z","caller":"traceutil/trace.go:171","msg":"trace[1923642341] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.935543574s","start":"2026-07-17T14:24:55.205367Z","end":"2026-07-17T14:24:57.140911Z","steps":["trace[1923642341] 'process raft request' (duration: 1.935267917s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.205348Z","time spent":"1.935653176s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.141079Z","caller":"traceutil/trace.go:171","msg":"trace[544491271] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.935620086s","start":"2026-07-17T14:24:55.205426Z","end":"2026-07-17T14:24:57.141046Z","steps":["trace[544491271] 'process raft request' (duration: 1.935417091s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.205421Z","time spent":"1.935731378s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.141388Z","caller":"traceutil/trace.go:171","msg":"trace[132063608] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.925672987s","start":"2026-07-17T14:24:55.2157Z","end":"2026-07-17T14:24:57.141373Z","steps":["trace[132063608] 'process raft request' (duration: 1.925383399s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.215692Z","time spent":"1.925745098s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.14144Z","caller":"traceutil/trace.go:171","msg":"trace[31481002] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.892357108s","start":"2026-07-17T14:24:55.249059Z","end":"2026-07-17T14:24:57.141416Z","steps":["trace[31481002] 'process raft request' (duration: 1.892311757s)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.141544Z","caller":"traceutil/trace.go:171","msg":"trace[1205437289] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.935680758s","start":"2026-07-17T14:24:55.205854Z","end":"2026-07-17T14:24:57.141535Z","steps":["trace[1205437289] 'process raft request' (duration: 1.93502749s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.205846Z","time spent":"1.935722419s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.141655Z","caller":"traceutil/trace.go:171","msg":"trace[1128467377] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"1.928874296s","start":"2026-07-17T14:24:55.212774Z","end":"2026-07-17T14:24:57.141648Z","steps":["trace[1128467377] 'process raft request' (duration: 1.928212529s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.212761Z","time spent":"1.928917368s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.141801Z","caller":"traceutil/trace.go:171","msg":"trace[2046244050] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.919298035s","start":"2026-07-17T14:24:55.222495Z","end":"2026-07-17T14:24:57.141793Z","steps":["trace[2046244050] 'process raft request' (duration: 1.91871382s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.222485Z","time spent":"1.919343146s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.141922Z","caller":"traceutil/trace.go:171","msg":"trace[676608737] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"1.926041585s","start":"2026-07-17T14:24:55.21587Z","end":"2026-07-17T14:24:57.141911Z","steps":["trace[676608737] 'process raft request' (duration: 1.925290265s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.141879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.249034Z","time spent":"1.892708787s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T14:24:57.14198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.215864Z","time spent":"1.926089937s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.14216Z","caller":"traceutil/trace.go:171","msg":"trace[478324001] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.915623403s","start":"2026-07-17T14:24:55.226522Z","end":"2026-07-17T14:24:57.142145Z","steps":["trace[478324001] 'process raft request' (duration: 1.914732201s)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.142195Z","caller":"traceutil/trace.go:171","msg":"trace[539721848] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.903637062s","start":"2026-07-17T14:24:55.238542Z","end":"2026-07-17T14:24:57.142179Z","steps":["trace[539721848] 'process raft request' (duration: 1.90275329s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.142242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.226513Z","time spent":"1.915691915s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T14:24:57.14226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.238528Z","time spent":"1.903699124s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.310833Z","caller":"traceutil/trace.go:171","msg":"trace[471858762] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"2.040047984s","start":"2026-07-17T14:24:55.270759Z","end":"2026-07-17T14:24:57.310807Z","steps":["trace[471858762] 'process raft request' (duration: 1.996617401s)","trace[471858762] 'compare' (duration: 43.077834ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:24:57.310896Z","caller":"traceutil/trace.go:171","msg":"trace[1470275719] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:515; }","duration":"2.040879955s","start":"2026-07-17T14:24:55.269994Z","end":"2026-07-17T14:24:57.310874Z","steps":["trace[1470275719] 'read index received' (duration: 1.870780134s)","trace[1470275719] 'applied index is now lower than readState.Index' (duration: 170.098901ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:24:57.310984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.270743Z","time spent":"2.040183598s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.311006Z","caller":"traceutil/trace.go:171","msg":"trace[174918326] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.90507268s","start":"2026-07-17T14:24:55.405918Z","end":"2026-07-17T14:24:57.310991Z","steps":["trace[174918326] 'process raft request' (duration: 1.904854294s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.311149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.405888Z","time spent":"1.905238724s","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:24:57.311139Z","caller":"traceutil/trace.go:171","msg":"trace[2070458144] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.992703124s","start":"2026-07-17T14:24:55.318413Z","end":"2026-07-17T14:24:57.311116Z","steps":["trace[2070458144] 'process raft request' (duration: 1.992223252s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.311209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.243466591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-17T14:24:57.311286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.244509148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-17T14:24:57.311273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.318394Z","time spent":"1.992801466s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:24:57.311319Z","caller":"traceutil/trace.go:171","msg":"trace[876233254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"2.24457408s","start":"2026-07-17T14:24:55.066735Z","end":"2026-07-17T14:24:57.311309Z","steps":["trace[876233254] 'agreement among raft nodes before linearized reading' (duration: 2.244485667s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.311357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.066722Z","time spent":"2.244628951s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T14:24:57.311305Z","caller":"traceutil/trace.go:171","msg":"trace[1720825802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"2.243604055s","start":"2026-07-17T14:24:55.067686Z","end":"2026-07-17T14:24:57.31129Z","steps":["trace[1720825802] 'agreement among raft nodes before linearized reading' (duration: 2.243343049s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.311535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.06767Z","time spent":"2.243848031s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-17T14:24:57.325983Z","caller":"traceutil/trace.go:171","msg":"trace[37657729] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"169.028983ms","start":"2026-07-17T14:24:57.156942Z","end":"2026-07-17T14:24:57.325971Z","steps":["trace[37657729] 'process raft request' (duration: 168.929601ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.325975Z","caller":"traceutil/trace.go:171","msg":"trace[2006137470] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"169.066045ms","start":"2026-07-17T14:24:57.156887Z","end":"2026-07-17T14:24:57.325953Z","steps":["trace[2006137470] 'process raft request' (duration: 168.964042ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.326143Z","caller":"traceutil/trace.go:171","msg":"trace[1702427691] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"169.152377ms","start":"2026-07-17T14:24:57.156968Z","end":"2026-07-17T14:24:57.32612Z","steps":["trace[1702427691] 'process raft request' (duration: 168.921841ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.326306Z","caller":"traceutil/trace.go:171","msg":"trace[1779495085] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"169.074865ms","start":"2026-07-17T14:24:57.157225Z","end":"2026-07-17T14:24:57.326299Z","steps":["trace[1779495085] 'process raft request' (duration: 168.688595ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.32644Z","caller":"traceutil/trace.go:171","msg":"trace[1114379214] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"173.214968ms","start":"2026-07-17T14:24:57.152716Z","end":"2026-07-17T14:24:57.325931Z","steps":["trace[1114379214] 'process raft request' (duration: 173.047294ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.326649Z","caller":"traceutil/trace.go:171","msg":"trace[683455001] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"169.22643ms","start":"2026-07-17T14:24:57.157412Z","end":"2026-07-17T14:24:57.326639Z","steps":["trace[683455001] 'process raft request' (duration: 169.151518ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.326673Z","caller":"traceutil/trace.go:171","msg":"trace[1705923305] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"169.376233ms","start":"2026-07-17T14:24:57.157282Z","end":"2026-07-17T14:24:57.326658Z","steps":["trace[1705923305] 'process raft request' (duration: 169.210179ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.326809Z","caller":"traceutil/trace.go:171","msg":"trace[1063036086] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"168.381938ms","start":"2026-07-17T14:24:57.15842Z","end":"2026-07-17T14:24:57.326802Z","steps":["trace[1063036086] 'process raft request' (duration: 168.176663ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.327251Z","caller":"traceutil/trace.go:171","msg":"trace[212848205] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"164.670054ms","start":"2026-07-17T14:24:57.162568Z","end":"2026-07-17T14:24:57.327238Z","steps":["trace[212848205] 'process raft request' (duration: 164.224543ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.327356Z","caller":"traceutil/trace.go:171","msg":"trace[96974809] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"163.676689ms","start":"2026-07-17T14:24:57.163665Z","end":"2026-07-17T14:24:57.327342Z","steps":["trace[96974809] 'process raft request' (duration: 163.435263ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:24:57.327347Z","caller":"traceutil/trace.go:171","msg":"trace[941906213] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"162.616823ms","start":"2026-07-17T14:24:57.164716Z","end":"2026-07-17T14:24:57.327333Z","steps":["trace[941906213] 'process raft request' (duration: 162.530471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.351865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.795039632s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.159\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-17T14:24:57.351908Z","caller":"traceutil/trace.go:171","msg":"trace[1531151067] range","detail":"{range_begin:/registry/masterleases/199.19.213.159; range_end:; response_count:1; response_revision:521; }","duration":"1.795124124s","start":"2026-07-17T14:24:55.556774Z","end":"2026-07-17T14:24:57.351898Z","steps":["trace[1531151067] 'agreement among raft nodes before linearized reading' (duration: 1.795035092s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.351925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.556754Z","time spent":"1.795166426s","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.159\" "} {"level":"warn","ts":"2026-07-17T14:24:57.352034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.94796832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:24:57.352052Z","caller":"traceutil/trace.go:171","msg":"trace[1456404941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"1.948018021s","start":"2026-07-17T14:24:55.404029Z","end":"2026-07-17T14:24:57.352047Z","steps":["trace[1456404941] 'agreement among raft nodes before linearized reading' (duration: 1.947951539s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:24:57.352064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:24:55.404009Z","time spent":"1.948052632s","remote":"127.0.0.1:32786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T14:25:02.460129Z","caller":"traceutil/trace.go:171","msg":"trace[554305017] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"118.918455ms","start":"2026-07-17T14:25:02.341175Z","end":"2026-07-17T14:25:02.460093Z","steps":["trace[554305017] 'process raft request' (duration: 98.378548ms)","trace[554305017] 'compare' (duration: 20.282311ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:03.855908Z","caller":"traceutil/trace.go:171","msg":"trace[2005828208] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"342.44086ms","start":"2026-07-17T14:25:03.513443Z","end":"2026-07-17T14:25:03.855883Z","steps":["trace[2005828208] 'process raft request' (duration: 341.899486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:03.856054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:03.513429Z","time spent":"342.552222ms","remote":"127.0.0.1:32930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:05.068565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304261,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:05.466785Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.086650293s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T14:25:05.471541Z","caller":"traceutil/trace.go:171","msg":"trace[1726536508] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"903.025275ms","start":"2026-07-17T14:25:04.568474Z","end":"2026-07-17T14:25:05.4715Z","steps":["trace[1726536508] 'read index received' (duration: 898.459499ms)","trace[1726536508] 'applied index is now lower than readState.Index' (duration: 4.564516ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:05.471599Z","caller":"traceutil/trace.go:171","msg":"trace[237010319] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.105973171s","start":"2026-07-17T14:25:04.365595Z","end":"2026-07-17T14:25:05.471568Z","steps":["trace[237010319] 'process raft request' (duration: 1.10394715s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:05.471812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.328713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w6jcm\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-07-17T14:25:05.471857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.626124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:25:05.471869Z","caller":"traceutil/trace.go:171","msg":"trace[1568760059] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w6jcm; range_end:; response_count:1; response_revision:608; }","duration":"903.446605ms","start":"2026-07-17T14:25:04.568406Z","end":"2026-07-17T14:25:05.471852Z","steps":["trace[1568760059] 'agreement among raft nodes before linearized reading' (duration: 903.253581ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:05.471908Z","caller":"traceutil/trace.go:171","msg":"trace[118522113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"113.758487ms","start":"2026-07-17T14:25:05.358134Z","end":"2026-07-17T14:25:05.471893Z","steps":["trace[118522113] 'agreement among raft nodes before linearized reading' (duration: 113.571073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:05.471911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:04.568381Z","time spent":"903.519977ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-w6jcm\" "} {"level":"warn","ts":"2026-07-17T14:25:05.472392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:04.365563Z","time spent":"1.106693599s","remote":"127.0.0.1:32930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:06.041453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304265,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:07.104376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.126404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T14:25:07.104784Z","caller":"traceutil/trace.go:171","msg":"trace[421934264] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:632; }","duration":"1.564314626s","start":"2026-07-17T14:25:05.54045Z","end":"2026-07-17T14:25:07.104765Z","steps":["trace[421934264] 'read index received' (duration: 689.486935ms)","trace[421934264] 'applied index is now lower than readState.Index' (duration: 874.826391ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:07.104898Z","caller":"traceutil/trace.go:171","msg":"trace[252002133] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.629058719s","start":"2026-07-17T14:25:05.475827Z","end":"2026-07-17T14:25:07.104886Z","steps":["trace[252002133] 'process raft request' (duration: 754.096725ms)","trace[252002133] 'compare' (duration: 873.820756ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:07.104921Z","caller":"traceutil/trace.go:171","msg":"trace[433763571] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.606444599s","start":"2026-07-17T14:25:05.498448Z","end":"2026-07-17T14:25:07.104892Z","steps":["trace[433763571] 'process raft request' (duration: 1.606244424s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.104962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.475812Z","time spent":"1.62911745s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:07.104991Z","caller":"traceutil/trace.go:171","msg":"trace[1672653552] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.628975187s","start":"2026-07-17T14:25:05.475985Z","end":"2026-07-17T14:25:07.10496Z","steps":["trace[1672653552] 'process raft request' (duration: 1.628543216s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.1051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.498424Z","time spent":"1.606579662s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:07.105117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.547918853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.159\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-17T14:25:07.105136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.475975Z","time spent":"1.62908108s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:07.105195Z","caller":"traceutil/trace.go:171","msg":"trace[1643362217] range","detail":"{range_begin:/registry/masterleases/199.19.213.159; range_end:; response_count:1; response_revision:613; }","duration":"1.548035567s","start":"2026-07-17T14:25:05.55714Z","end":"2026-07-17T14:25:07.105176Z","steps":["trace[1643362217] 'agreement among raft nodes before linearized reading' (duration: 1.547801621s)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:07.105223Z","caller":"traceutil/trace.go:171","msg":"trace[1281318459] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.620757729s","start":"2026-07-17T14:25:05.484455Z","end":"2026-07-17T14:25:07.105213Z","steps":["trace[1281318459] 'process raft request' (duration: 1.620178255s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.105187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.564715847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-17T14:25:07.105237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.557127Z","time spent":"1.548101438s","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.159\" "} {"level":"warn","ts":"2026-07-17T14:25:07.105265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.484444Z","time spent":"1.620799191s","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:07.105274Z","caller":"traceutil/trace.go:171","msg":"trace[84284822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"1.56484933s","start":"2026-07-17T14:25:05.540402Z","end":"2026-07-17T14:25:07.105251Z","steps":["trace[84284822] 'agreement among raft nodes before linearized reading' (duration: 1.564481921s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.105319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.540384Z","time spent":"1.564926042s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-17T14:25:07.105338Z","caller":"traceutil/trace.go:171","msg":"trace[1730877144] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.556843518s","start":"2026-07-17T14:25:05.548486Z","end":"2026-07-17T14:25:07.105329Z","steps":["trace[1730877144] 'process raft request' (duration: 1.556240073s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.105383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:05.548459Z","time spent":"1.556903029s","remote":"127.0.0.1:33076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T14:25:07.620584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.198364ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-07-17T14:25:07.620856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.106293Z","time spent":"514.558909ms","remote":"127.0.0.1:32844","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-17T14:25:07.620884Z","caller":"traceutil/trace.go:171","msg":"trace[667173633] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"510.314392ms","start":"2026-07-17T14:25:07.110553Z","end":"2026-07-17T14:25:07.620867Z","steps":["trace[667173633] 'read index received' (duration: 266.840881ms)","trace[667173633] 'applied index is now lower than readState.Index' (duration: 243.471261ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:07.621026Z","caller":"traceutil/trace.go:171","msg":"trace[2099514795] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"510.719682ms","start":"2026-07-17T14:25:07.110276Z","end":"2026-07-17T14:25:07.620995Z","steps":["trace[2099514795] 'process raft request' (duration: 510.484886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.621174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.110254Z","time spent":"510.845575ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:07.6212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.64188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-17T14:25:07.621242Z","caller":"traceutil/trace.go:171","msg":"trace[560790810] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:614; }","duration":"510.723173ms","start":"2026-07-17T14:25:07.110503Z","end":"2026-07-17T14:25:07.621226Z","steps":["trace[560790810] 'agreement among raft nodes before linearized reading' (duration: 510.64715ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:07.621273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.110487Z","time spent":"510.779384ms","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-07-17T14:25:08.121671Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304277,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:08.621831Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304277,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:09.121926Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304277,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:09.404171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000135399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-17T14:25:09.404256Z","caller":"traceutil/trace.go:171","msg":"trace[1118552139] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000270753s","start":"2026-07-17T14:25:07.403964Z","end":"2026-07-17T14:25:09.404234Z","steps":["trace[1118552139] 'agreement among raft nodes before linearized reading' (duration: 2.00016515s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:09.404305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.403943Z","time spent":"2.000352424s","remote":"127.0.0.1:32786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T14:25:09.483509Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.046658433s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-17T14:25:10.662419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177968348s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T14:25:10.662622Z","caller":"traceutil/trace.go:171","msg":"trace[347830408] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"3.225904352s","start":"2026-07-17T14:25:07.436689Z","end":"2026-07-17T14:25:10.662593Z","steps":["trace[347830408] 'process raft request' (duration: 2.047012132s)","trace[347830408] 'compare' (duration: 1.177821144s)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:10.662694Z","caller":"traceutil/trace.go:171","msg":"trace[531284758] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"3.040406714s","start":"2026-07-17T14:25:07.622279Z","end":"2026-07-17T14:25:10.662686Z","steps":["trace[531284758] 'process raft request' (duration: 3.040235909s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.662756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.62226Z","time spent":"3.040462266s","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:10.66278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.436664Z","time spent":"3.226035136s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:10.662653Z","caller":"traceutil/trace.go:171","msg":"trace[370813075] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:639; }","duration":"3.041718997s","start":"2026-07-17T14:25:07.620918Z","end":"2026-07-17T14:25:10.662637Z","steps":["trace[370813075] 'read index received' (duration: 1.862775135s)","trace[370813075] 'applied index is now lower than readState.Index' (duration: 1.178942992s)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:10.662891Z","caller":"traceutil/trace.go:171","msg":"trace[227476649] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.359912728s","start":"2026-07-17T14:25:09.302955Z","end":"2026-07-17T14:25:10.662868Z","steps":["trace[227476649] 'process raft request' (duration: 1.359640591s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.662979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.038523166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-17T14:25:10.663014Z","caller":"traceutil/trace.go:171","msg":"trace[1923959793] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:617; }","duration":"3.038557447s","start":"2026-07-17T14:25:07.624448Z","end":"2026-07-17T14:25:10.663005Z","steps":["trace[1923959793] 'agreement among raft nodes before linearized reading' (duration: 3.038491915s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.663011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.30293Z","time spent":"1.36002654s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:10.663046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:07.624414Z","time spent":"3.038625708s","remote":"127.0.0.1:33032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-07-17T14:25:10.663126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258234553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:10.663248Z","caller":"traceutil/trace.go:171","msg":"trace[1962439142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"1.258347755s","start":"2026-07-17T14:25:09.404838Z","end":"2026-07-17T14:25:10.663185Z","steps":["trace[1962439142] 'agreement among raft nodes before linearized reading' (duration: 1.258237132s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.663305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.404819Z","time spent":"1.258475329s","remote":"127.0.0.1:32798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T14:25:10.663338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.553274537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T14:25:10.663371Z","caller":"traceutil/trace.go:171","msg":"trace[1751016221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"1.553331258s","start":"2026-07-17T14:25:09.110031Z","end":"2026-07-17T14:25:10.663362Z","steps":["trace[1751016221] 'agreement among raft nodes before linearized reading' (duration: 1.553139074s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.663397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.110019Z","time spent":"1.553372269s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:25:10.663569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033002299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T14:25:10.663609Z","caller":"traceutil/trace.go:171","msg":"trace[428348007] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"1.033069961s","start":"2026-07-17T14:25:09.63053Z","end":"2026-07-17T14:25:10.6636Z","steps":["trace[428348007] 'agreement among raft nodes before linearized reading' (duration: 1.032946647s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.663637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.630512Z","time spent":"1.033119652s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:25:10.664075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.554216431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T14:25:10.664335Z","caller":"traceutil/trace.go:171","msg":"trace[343890659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"1.554518679s","start":"2026-07-17T14:25:09.109802Z","end":"2026-07-17T14:25:10.664321Z","steps":["trace[343890659] 'agreement among raft nodes before linearized reading' (duration: 1.553913904s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.664374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.109791Z","time spent":"1.55457177s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T14:25:10.667853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558331485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:25:10.667892Z","caller":"traceutil/trace.go:171","msg":"trace[1136213363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"1.558417877s","start":"2026-07-17T14:25:09.109466Z","end":"2026-07-17T14:25:10.667884Z","steps":["trace[1136213363] 'agreement among raft nodes before linearized reading' (duration: 1.553941004s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:10.667914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:09.109445Z","time spent":"1.558464629s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T14:25:13.238566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.505617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-17T14:25:13.238664Z","caller":"traceutil/trace.go:171","msg":"trace[1084247780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"515.670591ms","start":"2026-07-17T14:25:12.72296Z","end":"2026-07-17T14:25:13.23863Z","steps":["trace[1084247780] 'range keys from in-memory index tree' (duration: 515.23863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.238714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.722939Z","time spent":"515.765103ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:25:13.238708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.99011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:13.238784Z","caller":"traceutil/trace.go:171","msg":"trace[320767528] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:654; }","duration":"476.111282ms","start":"2026-07-17T14:25:12.762656Z","end":"2026-07-17T14:25:13.238767Z","steps":["trace[320767528] 'count revisions from in-memory index tree' (duration: 475.853516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.238832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.76264Z","time spent":"476.182354ms","remote":"127.0.0.1:33168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-17T14:25:13.239056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.184074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T14:25:13.239095Z","caller":"traceutil/trace.go:171","msg":"trace[503873987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"516.246635ms","start":"2026-07-17T14:25:12.722839Z","end":"2026-07-17T14:25:13.239085Z","steps":["trace[503873987] 'range keys from in-memory index tree' (duration: 516.099552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.23913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.72283Z","time spent":"516.286407ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T14:25:13.23924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.616275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T14:25:13.239388Z","caller":"traceutil/trace.go:171","msg":"trace[199419075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"516.82402ms","start":"2026-07-17T14:25:12.722543Z","end":"2026-07-17T14:25:13.239367Z","steps":["trace[199419075] 'range keys from in-memory index tree' (duration: 516.02472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.239476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.722522Z","time spent":"516.940063ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:25:13.239389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.893442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-17T14:25:13.239636Z","caller":"traceutil/trace.go:171","msg":"trace[1773817269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"517.166989ms","start":"2026-07-17T14:25:12.722455Z","end":"2026-07-17T14:25:13.239621Z","steps":["trace[1773817269] 'range keys from in-memory index tree' (duration: 516.795159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.239741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.72244Z","time spent":"517.286462ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T14:25:13.254125Z","caller":"traceutil/trace.go:171","msg":"trace[1802314066] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"362.509754ms","start":"2026-07-17T14:25:12.891563Z","end":"2026-07-17T14:25:13.254073Z","steps":["trace[1802314066] 'process raft request' (duration: 362.325319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:13.254322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:12.891531Z","time spent":"362.671667ms","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T14:25:13.262944Z","caller":"traceutil/trace.go:171","msg":"trace[1938298798] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"174.951288ms","start":"2026-07-17T14:25:13.087973Z","end":"2026-07-17T14:25:13.262924Z","steps":["trace[1938298798] 'process raft request' (duration: 174.690062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:16.148445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.938346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T14:25:16.148537Z","caller":"traceutil/trace.go:171","msg":"trace[2025466020] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:694; }","duration":"216.09289ms","start":"2026-07-17T14:25:15.932426Z","end":"2026-07-17T14:25:16.148519Z","steps":["trace[2025466020] 'count revisions from in-memory index tree' (duration: 215.833953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:16.148731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.302733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-07-17T14:25:16.14892Z","caller":"traceutil/trace.go:171","msg":"trace[1522654887] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"263.622362ms","start":"2026-07-17T14:25:15.885203Z","end":"2026-07-17T14:25:16.148825Z","steps":["trace[1522654887] 'range keys from in-memory index tree' (duration: 263.119876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.220303Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304592,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T14:25:23.37601Z","caller":"traceutil/trace.go:171","msg":"trace[202632264] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"662.902738ms","start":"2026-07-17T14:25:22.713087Z","end":"2026-07-17T14:25:23.37599Z","steps":["trace[202632264] 'read index received' (duration: 662.724983ms)","trace[202632264] 'applied index is now lower than readState.Index' (duration: 176.875µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:25:23.376057Z","caller":"traceutil/trace.go:171","msg":"trace[478292404] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"673.532877ms","start":"2026-07-17T14:25:22.702501Z","end":"2026-07-17T14:25:23.376033Z","steps":["trace[478292404] 'process raft request' (duration: 673.364203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.017471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.702488Z","time spent":"673.61464ms","remote":"127.0.0.1:33020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4857,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:23.376219Z","caller":"traceutil/trace.go:171","msg":"trace[970114188] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:757; }","duration":"663.084463ms","start":"2026-07-17T14:25:22.713126Z","end":"2026-07-17T14:25:23.37621Z","steps":["trace[970114188] 'agreement among raft nodes before linearized reading' (duration: 662.99796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.713122Z","time spent":"663.122294ms","remote":"127.0.0.1:37482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-07-17T14:25:23.376262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.165795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.064662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.607493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376337Z","caller":"traceutil/trace.go:171","msg":"trace[943926405] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:757; }","duration":"221.268658ms","start":"2026-07-17T14:25:23.155047Z","end":"2026-07-17T14:25:23.376316Z","steps":["trace[943926405] 'agreement among raft nodes before linearized reading' (duration: 221.162435ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.376371Z","caller":"traceutil/trace.go:171","msg":"trace[565452864] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:757; }","duration":"663.264398ms","start":"2026-07-17T14:25:22.713059Z","end":"2026-07-17T14:25:23.376323Z","steps":["trace[565452864] 'agreement among raft nodes before linearized reading' (duration: 663.034191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.847071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.544234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.37645Z","caller":"traceutil/trace.go:171","msg":"trace[26070733] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:757; }","duration":"221.587066ms","start":"2026-07-17T14:25:23.154856Z","end":"2026-07-17T14:25:23.376443Z","steps":["trace[26070733] 'agreement among raft nodes before linearized reading' (duration: 221.538155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.23054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376488Z","caller":"traceutil/trace.go:171","msg":"trace[747260421] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:757; }","duration":"133.256481ms","start":"2026-07-17T14:25:23.243224Z","end":"2026-07-17T14:25:23.37648Z","steps":["trace[747260421] 'agreement among raft nodes before linearized reading' (duration: 133.21787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.3765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.156081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.37656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.666622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376571Z","caller":"traceutil/trace.go:171","msg":"trace[440726767] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:757; }","duration":"205.257883ms","start":"2026-07-17T14:25:23.171299Z","end":"2026-07-17T14:25:23.376557Z","steps":["trace[440726767] 'agreement among raft nodes before linearized reading' (duration: 205.101099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.713042Z","time spent":"663.36478ms","remote":"127.0.0.1:37482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-17T14:25:23.376658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.170579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.610722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.490507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376712Z","caller":"traceutil/trace.go:171","msg":"trace[25054755] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:757; }","duration":"205.685203ms","start":"2026-07-17T14:25:23.171013Z","end":"2026-07-17T14:25:23.376698Z","steps":["trace[25054755] 'agreement among raft nodes before linearized reading' (duration: 205.601361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.378993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.37676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.988363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376773Z","caller":"traceutil/trace.go:171","msg":"trace[274898029] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:757; }","duration":"497.415693ms","start":"2026-07-17T14:25:22.879348Z","end":"2026-07-17T14:25:23.376764Z","steps":["trace[274898029] 'agreement among raft nodes before linearized reading' (duration: 497.388322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.37678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.793146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376786Z","caller":"traceutil/trace.go:171","msg":"trace[1296762427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:757; }","duration":"146.046634ms","start":"2026-07-17T14:25:23.230732Z","end":"2026-07-17T14:25:23.376779Z","steps":["trace[1296762427] 'agreement among raft nodes before linearized reading' (duration: 146.009904ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.376803Z","caller":"traceutil/trace.go:171","msg":"trace[2003493029] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:757; }","duration":"175.827057ms","start":"2026-07-17T14:25:23.200969Z","end":"2026-07-17T14:25:23.376796Z","steps":["trace[2003493029] 'agreement among raft nodes before linearized reading' (duration: 175.790626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.22099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376853Z","caller":"traceutil/trace.go:171","msg":"trace[2115824707] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:757; }","duration":"516.24329ms","start":"2026-07-17T14:25:22.860603Z","end":"2026-07-17T14:25:23.376847Z","steps":["trace[2115824707] 'agreement among raft nodes before linearized reading' (duration: 516.212309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.860575Z","time spent":"516.293251ms","remote":"127.0.0.1:37514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-17T14:25:23.376917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.494009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376944Z","caller":"traceutil/trace.go:171","msg":"trace[745505784] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:757; }","duration":"205.521779ms","start":"2026-07-17T14:25:23.171415Z","end":"2026-07-17T14:25:23.376937Z","steps":["trace[745505784] 'agreement among raft nodes before linearized reading' (duration: 205.482668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.78093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.971078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376988Z","caller":"traceutil/trace.go:171","msg":"trace[1368786840] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:757; }","duration":"221.849912ms","start":"2026-07-17T14:25:23.155125Z","end":"2026-07-17T14:25:23.376975Z","steps":["trace[1368786840] 'agreement among raft nodes before linearized reading' (duration: 221.77394ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377008Z","caller":"traceutil/trace.go:171","msg":"trace[829700419] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:757; }","duration":"517.031329ms","start":"2026-07-17T14:25:22.85997Z","end":"2026-07-17T14:25:23.377001Z","steps":["trace[829700419] 'agreement among raft nodes before linearized reading' (duration: 516.996898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.376612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.739494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.377078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.250161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377095Z","caller":"traceutil/trace.go:171","msg":"trace[90239728] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:757; }","duration":"558.304172ms","start":"2026-07-17T14:25:22.818787Z","end":"2026-07-17T14:25:23.377091Z","steps":["trace[90239728] 'agreement among raft nodes before linearized reading' (duration: 558.281352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.818766Z","time spent":"558.346744ms","remote":"127.0.0.1:37502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-07-17T14:25:23.376701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.970882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.87934Z","time spent":"497.452834ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-17T14:25:23.377219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.499153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.37725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.665508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.377244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.898597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377269Z","caller":"traceutil/trace.go:171","msg":"trace[1216601140] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:757; }","duration":"559.701399ms","start":"2026-07-17T14:25:22.817562Z","end":"2026-07-17T14:25:23.377263Z","steps":["trace[1216601140] 'agreement among raft nodes before linearized reading' (duration: 559.676598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.817549Z","time spent":"559.733119ms","remote":"127.0.0.1:37502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-07-17T14:25:23.377285Z","caller":"traceutil/trace.go:171","msg":"trace[6157763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:757; }","duration":"167.959019ms","start":"2026-07-17T14:25:23.209314Z","end":"2026-07-17T14:25:23.377273Z","steps":["trace[6157763] 'agreement among raft nodes before linearized reading' (duration: 167.899227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.64891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.335834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.377372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.065864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377391Z","caller":"traceutil/trace.go:171","msg":"trace[1078011604] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:757; }","duration":"582.095805ms","start":"2026-07-17T14:25:22.79529Z","end":"2026-07-17T14:25:23.377386Z","steps":["trace[1078011604] 'agreement among raft nodes before linearized reading' (duration: 582.066794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.795286Z","time spent":"582.123195ms","remote":"127.0.0.1:37498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-07-17T14:25:23.377412Z","caller":"traceutil/trace.go:171","msg":"trace[1727798586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:757; }","duration":"234.212326ms","start":"2026-07-17T14:25:23.143173Z","end":"2026-07-17T14:25:23.377385Z","steps":["trace[1727798586] 'agreement among raft nodes before linearized reading' (duration: 233.335254ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377343Z","caller":"traceutil/trace.go:171","msg":"trace[95704533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:757; }","duration":"234.272137ms","start":"2026-07-17T14:25:23.14284Z","end":"2026-07-17T14:25:23.377112Z","steps":["trace[95704533] 'agreement among raft nodes before linearized reading' (duration: 233.759674ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.376424Z","caller":"traceutil/trace.go:171","msg":"trace[2083489719] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:757; }","duration":"132.889472ms","start":"2026-07-17T14:25:23.243527Z","end":"2026-07-17T14:25:23.376416Z","steps":["trace[2083489719] 'agreement among raft nodes before linearized reading' (duration: 132.848991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.553516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.376726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.007733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377522Z","caller":"traceutil/trace.go:171","msg":"trace[883605014] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:757; }","duration":"582.588717ms","start":"2026-07-17T14:25:22.794927Z","end":"2026-07-17T14:25:23.377516Z","steps":["trace[883605014] 'agreement among raft nodes before linearized reading' (duration: 582.551266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.794924Z","time spent":"582.614097ms","remote":"127.0.0.1:37498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-17T14:25:23.377545Z","caller":"traceutil/trace.go:171","msg":"trace[253023038] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:757; }","duration":"497.856524ms","start":"2026-07-17T14:25:22.879678Z","end":"2026-07-17T14:25:23.377535Z","steps":["trace[253023038] 'agreement among raft nodes before linearized reading' (duration: 497.033864ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.376676Z","caller":"traceutil/trace.go:171","msg":"trace[1793255657] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:757; }","duration":"352.212241ms","start":"2026-07-17T14:25:23.024459Z","end":"2026-07-17T14:25:23.376672Z","steps":["trace[1793255657] 'agreement among raft nodes before linearized reading' (duration: 352.18796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.879657Z","time spent":"497.916615ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-17T14:25:23.377618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:23.024445Z","time spent":"353.160754ms","remote":"127.0.0.1:37524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-07-17T14:25:23.376588Z","caller":"traceutil/trace.go:171","msg":"trace[1185575351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:757; }","duration":"233.733384ms","start":"2026-07-17T14:25:23.142848Z","end":"2026-07-17T14:25:23.376582Z","steps":["trace[1185575351] 'agreement among raft nodes before linearized reading' (duration: 233.698133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.4013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.376722Z","caller":"traceutil/trace.go:171","msg":"trace[1116122984] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:757; }","duration":"133.546459ms","start":"2026-07-17T14:25:23.243167Z","end":"2026-07-17T14:25:23.376714Z","steps":["trace[1116122984] 'agreement among raft nodes before linearized reading' (duration: 133.495788ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377694Z","caller":"traceutil/trace.go:171","msg":"trace[2091050016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:757; }","duration":"621.42874ms","start":"2026-07-17T14:25:22.756259Z","end":"2026-07-17T14:25:23.377688Z","steps":["trace[2091050016] 'agreement among raft nodes before linearized reading' (duration: 621.399319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.756256Z","time spent":"621.461361ms","remote":"127.0.0.1:37482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-07-17T14:25:23.376637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.076007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377776Z","caller":"traceutil/trace.go:171","msg":"trace[932762380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:757; }","duration":"353.218825ms","start":"2026-07-17T14:25:23.024548Z","end":"2026-07-17T14:25:23.377767Z","steps":["trace[932762380] 'agreement among raft nodes before linearized reading' (duration: 352.074477ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.376352Z","caller":"traceutil/trace.go:171","msg":"trace[279229534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:757; }","duration":"145.691076ms","start":"2026-07-17T14:25:23.230649Z","end":"2026-07-17T14:25:23.37634Z","steps":["trace[279229534] 'agreement among raft nodes before linearized reading' (duration: 145.603863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.06016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377805Z","caller":"traceutil/trace.go:171","msg":"trace[21960275] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:757; }","duration":"517.84136ms","start":"2026-07-17T14:25:22.859959Z","end":"2026-07-17T14:25:23.3778Z","steps":["trace[21960275] 'agreement among raft nodes before linearized reading' (duration: 517.084701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.859939Z","time spent":"517.87953ms","remote":"127.0.0.1:37514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-17T14:25:23.377859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.658845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.377031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.859949Z","time spent":"517.077411ms","remote":"127.0.0.1:37514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-17T14:25:23.377875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.652146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:25:23.377646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.726861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.377912Z","caller":"traceutil/trace.go:171","msg":"trace[867956723] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:757; }","duration":"168.702126ms","start":"2026-07-17T14:25:23.2092Z","end":"2026-07-17T14:25:23.377902Z","steps":["trace[867956723] 'agreement among raft nodes before linearized reading' (duration: 168.646395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.903644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.37794Z","caller":"traceutil/trace.go:171","msg":"trace[757925524] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:757; }","duration":"583.046878ms","start":"2026-07-17T14:25:22.794887Z","end":"2026-07-17T14:25:23.377934Z","steps":["trace[757925524] 'agreement among raft nodes before linearized reading' (duration: 582.744171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.794872Z","time spent":"583.08892ms","remote":"127.0.0.1:37498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-17T14:25:23.377962Z","caller":"traceutil/trace.go:171","msg":"trace[603857257] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:757; }","duration":"176.979286ms","start":"2026-07-17T14:25:23.200969Z","end":"2026-07-17T14:25:23.377948Z","steps":["trace[603857257] 'agreement among raft nodes before linearized reading' (duration: 176.905444ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377925Z","caller":"traceutil/trace.go:171","msg":"trace[708739271] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:757; }","duration":"559.617387ms","start":"2026-07-17T14:25:22.817619Z","end":"2026-07-17T14:25:23.377236Z","steps":["trace[708739271] 'agreement among raft nodes before linearized reading' (duration: 559.586216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.377828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.607674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.378129Z","caller":"traceutil/trace.go:171","msg":"trace[1690349801] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:757; }","duration":"621.915112ms","start":"2026-07-17T14:25:22.756207Z","end":"2026-07-17T14:25:23.378122Z","steps":["trace[1690349801] 'agreement among raft nodes before linearized reading' (duration: 621.601124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.37807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.817599Z","time spent":"560.446657ms","remote":"127.0.0.1:37502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-07-17T14:25:23.378018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:23.024545Z","time spent":"353.467452ms","remote":"127.0.0.1:37524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-07-17T14:25:23.377733Z","caller":"traceutil/trace.go:171","msg":"trace[463724977] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:757; }","duration":"497.446024ms","start":"2026-07-17T14:25:22.879713Z","end":"2026-07-17T14:25:23.377159Z","steps":["trace[463724977] 'agreement among raft nodes before linearized reading' (duration: 496.975612ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377886Z","caller":"traceutil/trace.go:171","msg":"trace[1328890817] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:757; }","duration":"621.703677ms","start":"2026-07-17T14:25:22.756174Z","end":"2026-07-17T14:25:23.377877Z","steps":["trace[1328890817] 'agreement among raft nodes before linearized reading' (duration: 621.670416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:23.378417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.879706Z","time spent":"498.688925ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-17T14:25:23.378153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.756204Z","time spent":"621.941653ms","remote":"127.0.0.1:37488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-07-17T14:25:23.378451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:22.75616Z","time spent":"622.25839ms","remote":"127.0.0.1:37488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-17T14:25:23.378303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.283654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:23.383608Z","caller":"traceutil/trace.go:171","msg":"trace[793355364] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:757; }","duration":"182.592578ms","start":"2026-07-17T14:25:23.20097Z","end":"2026-07-17T14:25:23.383562Z","steps":["trace[793355364] 'agreement among raft nodes before linearized reading' (duration: 177.221212ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:25:23.377358Z","caller":"traceutil/trace.go:171","msg":"trace[1917797041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:757; }","duration":"146.69204ms","start":"2026-07-17T14:25:23.230649Z","end":"2026-07-17T14:25:23.377341Z","steps":["trace[1917797041] 'agreement among raft nodes before linearized reading' (duration: 146.649559ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:27.503992Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304641,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:28.0048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082304641,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:25:28.160297Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.580277571s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T14:25:28.161704Z","caller":"traceutil/trace.go:171","msg":"trace[1448318222] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"1.581790639s","start":"2026-07-17T14:25:26.579887Z","end":"2026-07-17T14:25:28.161678Z","steps":["trace[1448318222] 'process raft request' (duration: 1.581594164s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.161867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:26.579863Z","time spent":"1.581918572s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:25:28.176075Z","caller":"traceutil/trace.go:171","msg":"trace[116946071] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:812; }","duration":"1.172430319s","start":"2026-07-17T14:25:27.003615Z","end":"2026-07-17T14:25:28.176046Z","steps":["trace[116946071] 'read index received' (duration: 1.157898431s)","trace[116946071] 'applied index is now lower than readState.Index' (duration: 14.530828ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:25:28.176237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.172604504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T14:25:28.176296Z","caller":"traceutil/trace.go:171","msg":"trace[963854662] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:782; }","duration":"1.172710237s","start":"2026-07-17T14:25:27.003575Z","end":"2026-07-17T14:25:28.176285Z","steps":["trace[963854662] 'agreement among raft nodes before linearized reading' (duration: 1.172576933s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.176333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.003558Z","time spent":"1.172765928s","remote":"127.0.0.1:33286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-17T14:25:28.176104Z","caller":"traceutil/trace.go:171","msg":"trace[1912251692] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"1.479332746s","start":"2026-07-17T14:25:26.696739Z","end":"2026-07-17T14:25:28.176072Z","steps":["trace[1912251692] 'process raft request' (duration: 1.479141561s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.176504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.420247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:25:28.176535Z","caller":"traceutil/trace.go:171","msg":"trace[2125205363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"767.482779ms","start":"2026-07-17T14:25:27.409044Z","end":"2026-07-17T14:25:28.176527Z","steps":["trace[2125205363] 'agreement among raft nodes before linearized reading' (duration: 767.429597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.176525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:26.696712Z","time spent":"1.479696055s","remote":"127.0.0.1:33076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:25:28.176633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.409023Z","time spent":"767.529229ms","remote":"127.0.0.1:32786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T14:25:28.176669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.243605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T14:25:28.176737Z","caller":"traceutil/trace.go:171","msg":"trace[713119751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:782; }","duration":"698.366288ms","start":"2026-07-17T14:25:27.478353Z","end":"2026-07-17T14:25:28.176719Z","steps":["trace[713119751] 'agreement among raft nodes before linearized reading' (duration: 698.134203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.176767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.737253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-17T14:25:28.176787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.478325Z","time spent":"698.453271ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T14:25:28.176802Z","caller":"traceutil/trace.go:171","msg":"trace[743563739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"735.821697ms","start":"2026-07-17T14:25:27.44097Z","end":"2026-07-17T14:25:28.176792Z","steps":["trace[743563739] 'agreement among raft nodes before linearized reading' (duration: 735.702344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.176832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.440947Z","time spent":"735.878648ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T14:25:28.177139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.82946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T14:25:28.177415Z","caller":"traceutil/trace.go:171","msg":"trace[1819579843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"699.148788ms","start":"2026-07-17T14:25:27.478247Z","end":"2026-07-17T14:25:28.177396Z","steps":["trace[1819579843] 'agreement among raft nodes before linearized reading' (duration: 698.362749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.177567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.478227Z","time spent":"699.321702ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T14:25:28.177458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.40193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-17T14:25:28.177914Z","caller":"traceutil/trace.go:171","msg":"trace[1610864230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"698.892532ms","start":"2026-07-17T14:25:27.479012Z","end":"2026-07-17T14:25:28.177904Z","steps":["trace[1610864230] 'agreement among raft nodes before linearized reading' (duration: 697.504226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:25:28.177945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:25:27.478996Z","time spent":"698.939094ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T14:26:00.680222Z","caller":"traceutil/trace.go:171","msg":"trace[206594903] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"186.587593ms","start":"2026-07-17T14:26:00.493606Z","end":"2026-07-17T14:26:00.680194Z","steps":["trace[206594903] 'process raft request' (duration: 113.857364ms)","trace[206594903] 'compare' (duration: 72.522485ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:26:00.680497Z","caller":"traceutil/trace.go:171","msg":"trace[1703753484] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"186.288947ms","start":"2026-07-17T14:26:00.494189Z","end":"2026-07-17T14:26:00.680478Z","steps":["trace[1703753484] 'process raft request' (duration: 185.941721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:26:01.533373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.15001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:26:01.533421Z","caller":"traceutil/trace.go:171","msg":"trace[799887487] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"125.262726ms","start":"2026-07-17T14:26:01.408139Z","end":"2026-07-17T14:26:01.533402Z","steps":["trace[799887487] 'process raft request' (duration: 45.771995ms)","trace[799887487] 'compare' (duration: 79.322898ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:26:01.533455Z","caller":"traceutil/trace.go:171","msg":"trace[974621158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1027; }","duration":"130.277113ms","start":"2026-07-17T14:26:01.403161Z","end":"2026-07-17T14:26:01.533438Z","steps":["trace[974621158] 'range keys from in-memory index tree' (duration: 130.066879ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:02.875146Z","caller":"traceutil/trace.go:171","msg":"trace[832833511] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"186.18755ms","start":"2026-07-17T14:26:02.688929Z","end":"2026-07-17T14:26:02.875116Z","steps":["trace[832833511] 'process raft request' (duration: 145.48611ms)","trace[832833511] 'compare' (duration: 40.575938ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:26:03.447355Z","caller":"traceutil/trace.go:171","msg":"trace[2072950043] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"145.675971ms","start":"2026-07-17T14:26:03.30165Z","end":"2026-07-17T14:26:03.447325Z","steps":["trace[2072950043] 'process raft request' (duration: 145.502208ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:12.790317Z","caller":"traceutil/trace.go:171","msg":"trace[311070291] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"116.648867ms","start":"2026-07-17T14:26:12.673637Z","end":"2026-07-17T14:26:12.790286Z","steps":["trace[311070291] 'process raft request' (duration: 116.494304ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:15.694523Z","caller":"traceutil/trace.go:171","msg":"trace[102837989] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"130.931061ms","start":"2026-07-17T14:26:15.56357Z","end":"2026-07-17T14:26:15.694501Z","steps":["trace[102837989] 'process raft request' (duration: 130.784768ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:18.658754Z","caller":"traceutil/trace.go:171","msg":"trace[858071178] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"152.512186ms","start":"2026-07-17T14:26:18.506216Z","end":"2026-07-17T14:26:18.658728Z","steps":["trace[858071178] 'process raft request' (duration: 152.367023ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:27.333157Z","caller":"traceutil/trace.go:171","msg":"trace[1078049602] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"315.112017ms","start":"2026-07-17T14:26:27.018012Z","end":"2026-07-17T14:26:27.333124Z","steps":["trace[1078049602] 'process raft request' (duration: 314.836861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:26:27.333306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:26:27.017987Z","time spent":"315.24234ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:26:27.333297Z","caller":"traceutil/trace.go:171","msg":"trace[1879658461] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"260.176229ms","start":"2026-07-17T14:26:27.072873Z","end":"2026-07-17T14:26:27.333049Z","steps":["trace[1879658461] 'read index received' (duration: 259.963895ms)","trace[1879658461] 'applied index is now lower than readState.Index' (duration: 211.294µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:26:27.333447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.561278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-17T14:26:27.333528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.98341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-17T14:26:27.333544Z","caller":"traceutil/trace.go:171","msg":"trace[941679006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1111; }","duration":"260.742541ms","start":"2026-07-17T14:26:27.072775Z","end":"2026-07-17T14:26:27.333518Z","steps":["trace[941679006] 'agreement among raft nodes before linearized reading' (duration: 260.485926ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:27.333575Z","caller":"traceutil/trace.go:171","msg":"trace[775508167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1111; }","duration":"236.077973ms","start":"2026-07-17T14:26:27.097486Z","end":"2026-07-17T14:26:27.333564Z","steps":["trace[775508167] 'agreement among raft nodes before linearized reading' (duration: 235.922229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:26:30.908755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.550302ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-17T14:26:31.014639Z","caller":"traceutil/trace.go:171","msg":"trace[1939842895] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"101.640831ms","start":"2026-07-17T14:26:30.912965Z","end":"2026-07-17T14:26:31.014606Z","steps":["trace[1939842895] 'process raft request' (duration: 101.355646ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:26:31.223569Z","caller":"traceutil/trace.go:171","msg":"trace[314676852] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"204.621468ms","start":"2026-07-17T14:26:31.018908Z","end":"2026-07-17T14:26:31.22353Z","steps":["trace[314676852] 'process raft request' (duration: 151.254394ms)","trace[314676852] 'compare' (duration: 53.204281ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:13.716557Z","caller":"traceutil/trace.go:171","msg":"trace[365857702] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"212.161495ms","start":"2026-07-17T14:27:13.504378Z","end":"2026-07-17T14:27:13.71654Z","steps":["trace[365857702] 'read index received' (duration: 212.033042ms)","trace[365857702] 'applied index is now lower than readState.Index' (duration: 127.543µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:13.716833Z","caller":"traceutil/trace.go:171","msg":"trace[73168976] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"233.447725ms","start":"2026-07-17T14:27:13.483377Z","end":"2026-07-17T14:27:13.716825Z","steps":["trace[73168976] 'process raft request' (duration: 233.043176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:13.717023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.629306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T14:27:13.717048Z","caller":"traceutil/trace.go:171","msg":"trace[468739678] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1295; }","duration":"212.684127ms","start":"2026-07-17T14:27:13.504355Z","end":"2026-07-17T14:27:13.717039Z","steps":["trace[468739678] 'agreement among raft nodes before linearized reading' (duration: 212.621216ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:13.92175Z","caller":"traceutil/trace.go:171","msg":"trace[1893388293] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"152.941639ms","start":"2026-07-17T14:27:13.768787Z","end":"2026-07-17T14:27:13.921729Z","steps":["trace[1893388293] 'read index received' (duration: 148.293568ms)","trace[1893388293] 'applied index is now lower than readState.Index' (duration: 4.647371ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:13.921845Z","caller":"traceutil/trace.go:171","msg":"trace[1078601481] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"201.919065ms","start":"2026-07-17T14:27:13.719919Z","end":"2026-07-17T14:27:13.921838Z","steps":["trace[1078601481] 'process raft request' (duration: 197.267054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:13.922026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.233476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T14:27:13.922047Z","caller":"traceutil/trace.go:171","msg":"trace[552287955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1296; }","duration":"153.303996ms","start":"2026-07-17T14:27:13.768737Z","end":"2026-07-17T14:27:13.922041Z","steps":["trace[552287955] 'agreement among raft nodes before linearized reading' (duration: 153.199524ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:22.158518Z","caller":"traceutil/trace.go:171","msg":"trace[1016540755] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"111.361587ms","start":"2026-07-17T14:27:22.047135Z","end":"2026-07-17T14:27:22.158496Z","steps":["trace[1016540755] 'read index received' (duration: 107.912272ms)","trace[1016540755] 'applied index is now lower than readState.Index' (duration: 3.448445ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:22.158723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.573571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T14:27:22.158763Z","caller":"traceutil/trace.go:171","msg":"trace[1125084159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1328; }","duration":"111.656543ms","start":"2026-07-17T14:27:22.047096Z","end":"2026-07-17T14:27:22.158753Z","steps":["trace[1125084159] 'agreement among raft nodes before linearized reading' (duration: 111.49899ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:22.158783Z","caller":"traceutil/trace.go:171","msg":"trace[1757794359] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"113.757158ms","start":"2026-07-17T14:27:22.045003Z","end":"2026-07-17T14:27:22.15876Z","steps":["trace[1757794359] 'process raft request' (duration: 109.788971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:22.671552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":704707172082305943,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T14:27:23.096833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.467581ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T14:27:23.097606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.853908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T14:27:23.097885Z","caller":"traceutil/trace.go:171","msg":"trace[1123232811] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"965.499196ms","start":"2026-07-17T14:27:22.132363Z","end":"2026-07-17T14:27:23.097863Z","steps":["trace[1123232811] 'process raft request' (duration: 814.31325ms)","trace[1123232811] 'compare' (duration: 150.311747ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:23.098052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.132338Z","time spent":"965.598608ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:27:23.097405Z","caller":"traceutil/trace.go:171","msg":"trace[532623040] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1328; }","duration":"834.057763ms","start":"2026-07-17T14:27:22.263323Z","end":"2026-07-17T14:27:23.097381Z","steps":["trace[532623040] 'range keys from in-memory index tree' (duration: 833.44844ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:23.098717Z","caller":"traceutil/trace.go:171","msg":"trace[1123601031] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"961.05353ms","start":"2026-07-17T14:27:22.137649Z","end":"2026-07-17T14:27:23.098703Z","steps":["trace[1123601031] 'process raft request' (duration: 960.581009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:23.098861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.137637Z","time spent":"961.126031ms","remote":"127.0.0.1:33008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5898,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:27:23.171949Z","caller":"traceutil/trace.go:171","msg":"trace[502953223] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"1.009289811s","start":"2026-07-17T14:27:22.162638Z","end":"2026-07-17T14:27:23.171928Z","steps":["trace[502953223] 'process raft request' (duration: 1.009120118s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:23.172069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.162625Z","time spent":"1.009392574s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T14:27:23.172206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001127505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T14:27:23.172277Z","caller":"traceutil/trace.go:171","msg":"trace[17475774] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1331; }","duration":"1.001260508s","start":"2026-07-17T14:27:22.171003Z","end":"2026-07-17T14:27:23.172264Z","steps":["trace[17475774] 'agreement among raft nodes before linearized reading' (duration: 1.001110894s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:23.172348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.170994Z","time spent":"1.001341369s","remote":"127.0.0.1:33286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-17T14:27:23.171866Z","caller":"traceutil/trace.go:171","msg":"trace[1374893760] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1385; }","duration":"1.000827489s","start":"2026-07-17T14:27:22.171023Z","end":"2026-07-17T14:27:23.17185Z","steps":["trace[1374893760] 'read index received' (duration: 775.784292ms)","trace[1374893760] 'applied index is now lower than readState.Index' (duration: 225.042157ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:23.172773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.506108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:27:23.172841Z","caller":"traceutil/trace.go:171","msg":"trace[1422724463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1331; }","duration":"769.616471ms","start":"2026-07-17T14:27:22.403213Z","end":"2026-07-17T14:27:23.17283Z","steps":["trace[1422724463] 'agreement among raft nodes before linearized reading' (duration: 769.499858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:23.172897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.403184Z","time spent":"769.679643ms","remote":"127.0.0.1:32786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T14:27:23.172934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.984531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T14:27:23.173025Z","caller":"traceutil/trace.go:171","msg":"trace[2024887063] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1331; }","duration":"307.127304ms","start":"2026-07-17T14:27:22.865871Z","end":"2026-07-17T14:27:23.172999Z","steps":["trace[2024887063] 'agreement among raft nodes before linearized reading' (duration: 306.948831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:23.17308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:22.86585Z","time spent":"307.218906ms","remote":"127.0.0.1:32978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-07-17T14:27:23.636864Z","caller":"traceutil/trace.go:171","msg":"trace[41238979] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"289.040973ms","start":"2026-07-17T14:27:23.347799Z","end":"2026-07-17T14:27:23.63684Z","steps":["trace[41238979] 'process raft request' (duration: 223.566025ms)","trace[41238979] 'compare' (duration: 65.255754ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:23.778214Z","caller":"traceutil/trace.go:171","msg":"trace[1660929501] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"305.657676ms","start":"2026-07-17T14:27:23.472531Z","end":"2026-07-17T14:27:23.778189Z","steps":["trace[1660929501] 'process raft request' (duration: 270.994751ms)","trace[1660929501] 'compare' (duration: 34.512462ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:23.778348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T14:27:23.472507Z","time spent":"305.773058ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T14:27:23.778471Z","caller":"traceutil/trace.go:171","msg":"trace[665350390] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1388; }","duration":"281.201212ms","start":"2026-07-17T14:27:23.496951Z","end":"2026-07-17T14:27:23.778152Z","steps":["trace[665350390] 'read index received' (duration: 74.487344ms)","trace[665350390] 'applied index is now lower than readState.Index' (duration: 206.712958ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:23.778475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.495569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-17T14:27:23.778545Z","caller":"traceutil/trace.go:171","msg":"trace[81124106] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"281.613122ms","start":"2026-07-17T14:27:23.496917Z","end":"2026-07-17T14:27:23.77853Z","steps":["trace[81124106] 'agreement among raft nodes before linearized reading' (duration: 281.384707ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:23.952348Z","caller":"traceutil/trace.go:171","msg":"trace[1485501463] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"168.943624ms","start":"2026-07-17T14:27:23.783376Z","end":"2026-07-17T14:27:23.95232Z","steps":["trace[1485501463] 'process raft request' (duration: 142.762363ms)","trace[1485501463] 'compare' (duration: 26.065669ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:24.418774Z","caller":"traceutil/trace.go:171","msg":"trace[996388489] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"251.586543ms","start":"2026-07-17T14:27:24.167164Z","end":"2026-07-17T14:27:24.41875Z","steps":["trace[996388489] 'process raft request' (duration: 157.614461ms)","trace[996388489] 'compare' (duration: 93.491282ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:34.833312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.638139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"} {"level":"info","ts":"2026-07-17T14:27:34.833395Z","caller":"traceutil/trace.go:171","msg":"trace[740556933] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1374; }","duration":"119.759311ms","start":"2026-07-17T14:27:34.713614Z","end":"2026-07-17T14:27:34.833374Z","steps":["trace[740556933] 'range keys from in-memory index tree' (duration: 119.405003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:34.833797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.934319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium-operator\" ","response":"range_response_count:1 size:785"} {"level":"info","ts":"2026-07-17T14:27:34.833847Z","caller":"traceutil/trace.go:171","msg":"trace[516731573] range","detail":"{range_begin:/registry/clusterrolebindings/cilium-operator; range_end:; response_count:1; response_revision:1374; }","duration":"151.559342ms","start":"2026-07-17T14:27:34.682277Z","end":"2026-07-17T14:27:34.833836Z","steps":["trace[516731573] 'range keys from in-memory index tree' (duration: 150.673653ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:35.724298Z","caller":"traceutil/trace.go:171","msg":"trace[187525103] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"126.299929ms","start":"2026-07-17T14:27:35.597974Z","end":"2026-07-17T14:27:35.724273Z","steps":["trace[187525103] 'read index received' (duration: 37.59797ms)","trace[187525103] 'applied index is now lower than readState.Index' (duration: 88.700899ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T14:27:35.724374Z","caller":"traceutil/trace.go:171","msg":"trace[1181837217] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"128.693841ms","start":"2026-07-17T14:27:35.595627Z","end":"2026-07-17T14:27:35.724321Z","steps":["trace[1181837217] 'process raft request' (duration: 39.920751ms)","trace[1181837217] 'compare' (duration: 88.602026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T14:27:35.724477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.481612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:get-nodes\" ","response":"range_response_count:1 size:469"} {"level":"info","ts":"2026-07-17T14:27:35.724548Z","caller":"traceutil/trace.go:171","msg":"trace[2079388902] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:get-nodes; range_end:; response_count:1; response_revision:1377; }","duration":"126.577235ms","start":"2026-07-17T14:27:35.597952Z","end":"2026-07-17T14:27:35.724529Z","steps":["trace[2079388902] 'agreement among raft nodes before linearized reading' (duration: 126.399271ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T14:27:36.145251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.524438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-controller\" ","response":"range_response_count:1 size:663"} {"level":"info","ts":"2026-07-17T14:27:36.145335Z","caller":"traceutil/trace.go:171","msg":"trace[1733198482] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-controller; range_end:; response_count:1; response_revision:1378; }","duration":"108.644771ms","start":"2026-07-17T14:27:36.036671Z","end":"2026-07-17T14:27:36.145315Z","steps":["trace[1733198482] 'range keys from in-memory index tree' (duration: 108.381155ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T14:27:38.093092Z","caller":"traceutil/trace.go:171","msg":"trace[762556115] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"125.778624ms","start":"2026-07-17T14:27:37.96729Z","end":"2026-07-17T14:27:38.093069Z","steps":["trace[762556115] 'process raft request' (duration: 125.61591ms)"],"step_count":1}