{"level":"warn","ts":"2026-06-22T18:11:12.55304Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T18:11:12.553131Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-06-22T18:11:12.553211Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T18:11:12.553226Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-22T18:11:12.553246Z","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-06-22T18:11:12.553898Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-06-22T18:11:12.553971Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-06-22T18:11:12.558227Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.063704ms"} {"level":"info","ts":"2026-06-22T18:11:12.56446Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-06-22T18:11:12.564591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T18:11:12.564635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-06-22T18:11:12.564657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T18:11:12.564684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-06-22T18:11:12.564771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-06-22T18:11:12.572575Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T18:11:12.574207Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T18:11:12.575525Z","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-06-22T18:11:12.579107Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T18:11:12.58017Z","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-06-22T18:11:12.580247Z","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-06-22T18:11:12.58026Z","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-06-22T18:11:12.580208Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T18:11:12.581169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-06-22T18:11:12.581457Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-22T18:11:12.584971Z","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-06-22T18:11:12.585105Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-22T18:11:12.585266Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-22T18:11:12.585504Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T18:11:12.58553Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T18:11:12.665551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T18:11:12.665599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T18:11:12.665635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-06-22T18:11:12.665655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-06-22T18:11:12.665666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-22T18:11:12.665678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-06-22T18:11:12.665687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-22T18:11:12.666497Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T18:11:12.666578Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:11:12.666705Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:11:12.666944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:11:12.667597Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:11:12.667697Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:11:12.66773Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:11:12.667926Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T18:11:12.667948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T18:11:12.670624Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-06-22T18:11:12.671276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-22T18:11:14.760892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514347224052856,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-22T18:11:14.787842Z","caller":"traceutil/trace.go:171","msg":"trace[625622143] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"527.673218ms","start":"2026-06-22T18:11:14.260133Z","end":"2026-06-22T18:11:14.787806Z","steps":["trace[625622143] 'process raft request' (duration: 527.422547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.788489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.260122Z","time spent":"527.800574ms","remote":"127.0.0.1:51078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:11:14.954064Z","caller":"traceutil/trace.go:171","msg":"trace[1373972123] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"605.993479ms","start":"2026-06-22T18:11:14.34803Z","end":"2026-06-22T18:11:14.954024Z","steps":["trace[1373972123] 'process raft request' (duration: 605.821561ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:14.954102Z","caller":"traceutil/trace.go:171","msg":"trace[243976482] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"618.689684ms","start":"2026-06-22T18:11:14.335376Z","end":"2026-06-22T18:11:14.954065Z","steps":["trace[243976482] 'process raft request' (duration: 618.19945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.954245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.335361Z","time spent":"618.810378ms","remote":"127.0.0.1:51420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.954244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.348017Z","time spent":"606.145606ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.954289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.455509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.954084Z","caller":"traceutil/trace.go:171","msg":"trace[976790908] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"607.486347ms","start":"2026-06-22T18:11:14.346549Z","end":"2026-06-22T18:11:14.954035Z","steps":["trace[976790908] 'process raft request' (duration: 607.262727ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:14.954425Z","caller":"traceutil/trace.go:171","msg":"trace[51057296] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"606.194967ms","start":"2026-06-22T18:11:14.348218Z","end":"2026-06-22T18:11:14.954413Z","steps":["trace[51057296] 'process raft request' (duration: 605.674304ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:14.954504Z","caller":"traceutil/trace.go:171","msg":"trace[1050816841] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"605.739576ms","start":"2026-06-22T18:11:14.34875Z","end":"2026-06-22T18:11:14.954489Z","steps":["trace[1050816841] 'process raft request' (duration: 605.216292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.954551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.348207Z","time spent":"606.286502ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.954583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.348718Z","time spent":"605.830781ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:14.954641Z","caller":"traceutil/trace.go:171","msg":"trace[1993257304] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"605.717225ms","start":"2026-06-22T18:11:14.348912Z","end":"2026-06-22T18:11:14.954629Z","steps":["trace[1993257304] 'process raft request' (duration: 605.086397ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:14.954697Z","caller":"traceutil/trace.go:171","msg":"trace[744341130] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"605.992959ms","start":"2026-06-22T18:11:14.348691Z","end":"2026-06-22T18:11:14.954684Z","steps":["trace[744341130] 'process raft request' (duration: 605.233164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.954711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.348903Z","time spent":"605.776468ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.954757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.348682Z","time spent":"606.049741ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:14.954072Z","caller":"traceutil/trace.go:171","msg":"trace[660787349] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"693.2661ms","start":"2026-06-22T18:11:14.260771Z","end":"2026-06-22T18:11:14.954037Z","steps":["trace[660787349] 'read index received' (duration: 527.090981ms)","trace[660787349] 'applied index is now lower than readState.Index' (duration: 166.173809ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:11:14.95438Z","caller":"traceutil/trace.go:171","msg":"trace[253154229] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"693.605046ms","start":"2026-06-22T18:11:14.260756Z","end":"2026-06-22T18:11:14.954361Z","steps":["trace[253154229] 'agreement among raft nodes before linearized reading' (duration: 693.377796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.791251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.955095Z","caller":"traceutil/trace.go:171","msg":"trace[1173173524] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"681.869724ms","start":"2026-06-22T18:11:14.27321Z","end":"2026-06-22T18:11:14.95508Z","steps":["trace[1173173524] 'agreement among raft nodes before linearized reading' (duration: 681.78418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.321794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T18:11:14.955143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.2732Z","time spent":"681.931697ms","remote":"127.0.0.1:51362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-06-22T18:11:14.955168Z","caller":"traceutil/trace.go:171","msg":"trace[87181647] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"616.397267ms","start":"2026-06-22T18:11:14.338755Z","end":"2026-06-22T18:11:14.955152Z","steps":["trace[87181647] 'agreement among raft nodes before linearized reading' (duration: 616.321324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.338741Z","time spent":"616.45735ms","remote":"127.0.0.1:51096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-22T18:11:14.955345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.847808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T18:11:14.95535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.724103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.955378Z","caller":"traceutil/trace.go:171","msg":"trace[19493202] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"588.89771ms","start":"2026-06-22T18:11:14.366472Z","end":"2026-06-22T18:11:14.95537Z","steps":["trace[19493202] 'agreement among raft nodes before linearized reading' (duration: 588.851368ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:14.9554Z","caller":"traceutil/trace.go:171","msg":"trace[1113957679] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:0; response_revision:10; }","duration":"621.812787ms","start":"2026-06-22T18:11:14.333574Z","end":"2026-06-22T18:11:14.955387Z","steps":["trace[1113957679] 'agreement among raft nodes before linearized reading' (duration: 621.743924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.833056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T18:11:14.95544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.33355Z","time spent":"621.88074ms","remote":"127.0.0.1:51044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-06-22T18:11:14.955456Z","caller":"traceutil/trace.go:171","msg":"trace[1750939002] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"545.909239ms","start":"2026-06-22T18:11:14.409533Z","end":"2026-06-22T18:11:14.955443Z","steps":["trace[1750939002] 'agreement among raft nodes before linearized reading' (duration: 545.819214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.409523Z","time spent":"545.971672ms","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T18:11:14.955539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.069591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.955574Z","caller":"traceutil/trace.go:171","msg":"trace[1574787309] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"550.103742ms","start":"2026-06-22T18:11:14.405462Z","end":"2026-06-22T18:11:14.955566Z","steps":["trace[1574787309] 'agreement among raft nodes before linearized reading' (duration: 550.05731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.405369Z","time spent":"550.230118ms","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T18:11:14.955409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.366462Z","time spent":"588.941022ms","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T18:11:14.955693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.831409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.955738Z","caller":"traceutil/trace.go:171","msg":"trace[673916268] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"544.893102ms","start":"2026-06-22T18:11:14.410833Z","end":"2026-06-22T18:11:14.955726Z","steps":["trace[673916268] 'agreement among raft nodes before linearized reading' (duration: 544.829969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.955821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.410824Z","time spent":"544.980235ms","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T18:11:14.9564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.346534Z","time spent":"609.791052ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.956923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.678193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:14.957017Z","caller":"traceutil/trace.go:171","msg":"trace[563439600] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"567.807579ms","start":"2026-06-22T18:11:14.389188Z","end":"2026-06-22T18:11:14.956996Z","steps":["trace[563439600] 'agreement among raft nodes before linearized reading' (duration: 565.89123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.957063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.389178Z","time spent":"567.875991ms","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-22T18:11:14.958375Z","caller":"traceutil/trace.go:171","msg":"trace[1825053545] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"608.139447ms","start":"2026-06-22T18:11:14.346393Z","end":"2026-06-22T18:11:14.954533Z","steps":["trace[1825053545] 'process raft request' (duration: 607.35141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:14.958574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.346352Z","time spent":"612.090799ms","remote":"127.0.0.1:51178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:14.954912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:14.26075Z","time spent":"694.12657ms","remote":"127.0.0.1:51072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-06-22T18:11:15.111364Z","caller":"traceutil/trace.go:171","msg":"trace[23481362] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"150.711299ms","start":"2026-06-22T18:11:14.960609Z","end":"2026-06-22T18:11:15.11132Z","steps":["trace[23481362] 'process raft request' (duration: 81.075348ms)","trace[23481362] 'compare' (duration: 69.486385ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:11:15.112036Z","caller":"traceutil/trace.go:171","msg":"trace[477338876] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"150.93631ms","start":"2026-06-22T18:11:14.961089Z","end":"2026-06-22T18:11:15.112025Z","steps":["trace[477338876] 'process raft request' (duration: 150.762762ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112134Z","caller":"traceutil/trace.go:171","msg":"trace[1968104648] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:14; }","duration":"151.053186ms","start":"2026-06-22T18:11:14.960991Z","end":"2026-06-22T18:11:15.112045Z","steps":["trace[1968104648] 'read index received' (duration: 80.694381ms)","trace[1968104648] 'applied index is now lower than readState.Index' (duration: 70.357745ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:11:15.112272Z","caller":"traceutil/trace.go:171","msg":"trace[804701640] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"151.074477ms","start":"2026-06-22T18:11:14.961187Z","end":"2026-06-22T18:11:15.112261Z","steps":["trace[804701640] 'process raft request' (duration: 150.692989ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.11246Z","caller":"traceutil/trace.go:171","msg":"trace[1518945508] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"151.235374ms","start":"2026-06-22T18:11:14.961215Z","end":"2026-06-22T18:11:15.112451Z","steps":["trace[1518945508] 'process raft request' (duration: 150.69625ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112586Z","caller":"traceutil/trace.go:171","msg":"trace[701324896] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"145.902668ms","start":"2026-06-22T18:11:14.966675Z","end":"2026-06-22T18:11:15.112577Z","steps":["trace[701324896] 'process raft request' (duration: 145.337382ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112726Z","caller":"traceutil/trace.go:171","msg":"trace[726127729] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"146.716415ms","start":"2026-06-22T18:11:14.965969Z","end":"2026-06-22T18:11:15.112686Z","steps":["trace[726127729] 'process raft request' (duration: 145.997012ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112803Z","caller":"traceutil/trace.go:171","msg":"trace[1438009809] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"151.824211ms","start":"2026-06-22T18:11:14.96097Z","end":"2026-06-22T18:11:15.112795Z","steps":["trace[1438009809] 'process raft request' (duration: 150.815345ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112757Z","caller":"traceutil/trace.go:171","msg":"trace[826594735] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"151.923466ms","start":"2026-06-22T18:11:14.960781Z","end":"2026-06-22T18:11:15.112704Z","steps":["trace[826594735] 'process raft request' (duration: 150.863217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:15.11292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.865893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:15.113025Z","caller":"traceutil/trace.go:171","msg":"trace[760644534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"152.050011ms","start":"2026-06-22T18:11:14.960962Z","end":"2026-06-22T18:11:15.113012Z","steps":["trace[760644534] 'agreement among raft nodes before linearized reading' (duration: 151.818221ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.113173Z","caller":"traceutil/trace.go:171","msg":"trace[1991215147] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"152.036871ms","start":"2026-06-22T18:11:14.961124Z","end":"2026-06-22T18:11:15.113161Z","steps":["trace[1991215147] 'process raft request' (duration: 150.694699ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:15.112587Z","caller":"traceutil/trace.go:171","msg":"trace[2138346453] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"151.277106ms","start":"2026-06-22T18:11:14.961293Z","end":"2026-06-22T18:11:15.11257Z","steps":["trace[2138346453] 'process raft request' (duration: 150.640907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:15.113316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.247271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-ndnwj\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-06-22T18:11:15.11338Z","caller":"traceutil/trace.go:171","msg":"trace[666623726] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-ndnwj; range_end:; response_count:1; response_revision:20; }","duration":"152.334914ms","start":"2026-06-22T18:11:14.961029Z","end":"2026-06-22T18:11:15.113364Z","steps":["trace[666623726] 'agreement among raft nodes before linearized reading' (duration: 152.2407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:15.113538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.504948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T18:11:15.113589Z","caller":"traceutil/trace.go:171","msg":"trace[1046346798] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:20; }","duration":"151.581151ms","start":"2026-06-22T18:11:14.961998Z","end":"2026-06-22T18:11:15.113579Z","steps":["trace[1046346798] 'agreement among raft nodes before linearized reading' (duration: 151.515838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:15.113714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.41843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-06-22T18:11:15.113768Z","caller":"traceutil/trace.go:171","msg":"trace[2110871389] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"152.482362ms","start":"2026-06-22T18:11:14.961272Z","end":"2026-06-22T18:11:15.113754Z","steps":["trace[2110871389] 'agreement among raft nodes before linearized reading' (duration: 152.369957ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:16.483199Z","caller":"traceutil/trace.go:171","msg":"trace[1127774714] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"257.194271ms","start":"2026-06-22T18:11:16.225976Z","end":"2026-06-22T18:11:16.48317Z","steps":["trace[1127774714] 'process raft request' (duration: 236.556567ms)","trace[1127774714] 'compare' (duration: 20.365081ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:16.483308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.517789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:11:16.483344Z","caller":"traceutil/trace.go:171","msg":"trace[485583344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"162.613414ms","start":"2026-06-22T18:11:16.320722Z","end":"2026-06-22T18:11:16.483335Z","steps":["trace[485583344] 'agreement among raft nodes before linearized reading' (duration: 162.549361ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:16.483235Z","caller":"traceutil/trace.go:171","msg":"trace[1552540586] linearizableReadLoop","detail":"{readStateIndex:164; appliedIndex:163; }","duration":"162.437556ms","start":"2026-06-22T18:11:16.320781Z","end":"2026-06-22T18:11:16.483219Z","steps":["trace[1552540586] 'read index received' (duration: 141.728329ms)","trace[1552540586] 'applied index is now lower than readState.Index' (duration: 20.708227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:23.303205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514347224053551,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-22T18:11:23.401751Z","caller":"traceutil/trace.go:171","msg":"trace[810490998] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:368; }","duration":"599.239626ms","start":"2026-06-22T18:11:22.802488Z","end":"2026-06-22T18:11:23.401728Z","steps":["trace[810490998] 'read index received' (duration: 599.039967ms)","trace[810490998] 'applied index is now lower than readState.Index' (duration: 198.719µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:11:23.401855Z","caller":"traceutil/trace.go:171","msg":"trace[1466376750] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"639.279362ms","start":"2026-06-22T18:11:22.762541Z","end":"2026-06-22T18:11:23.401821Z","steps":["trace[1466376750] 'process raft request' (duration: 639.045261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.401908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.400315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-22T18:11:23.401948Z","caller":"traceutil/trace.go:171","msg":"trace[1743773960] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:354; }","duration":"599.473928ms","start":"2026-06-22T18:11:22.802462Z","end":"2026-06-22T18:11:23.401936Z","steps":["trace[1743773960] 'agreement among raft nodes before linearized reading' (duration: 599.394185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.401991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.802449Z","time spent":"599.532371ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:23.402048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.762522Z","time spent":"639.417409ms","remote":"127.0.0.1:51178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:11:23.402074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.785184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-06-22T18:11:23.402145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.96783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-06-22T18:11:23.40364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.159483ms","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-06-22T18:11:23.403845Z","caller":"traceutil/trace.go:171","msg":"trace[686594012] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:354; }","duration":"450.409655ms","start":"2026-06-22T18:11:22.953383Z","end":"2026-06-22T18:11:23.403793Z","steps":["trace[686594012] 'agreement among raft nodes before linearized reading' (duration: 448.705182ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:23.403887Z","caller":"traceutil/trace.go:171","msg":"trace[234903628] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:354; }","duration":"552.618303ms","start":"2026-06-22T18:11:22.851227Z","end":"2026-06-22T18:11:23.403845Z","steps":["trace[234903628] 'agreement among raft nodes before linearized reading' (duration: 550.802415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.403985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.594438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-22T18:11:23.403986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.851201Z","time spent":"552.760861ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:23.403943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.953359Z","time spent":"450.558172ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:23.404412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.14071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T18:11:23.404076Z","caller":"traceutil/trace.go:171","msg":"trace[1688861985] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:354; }","duration":"401.471809ms","start":"2026-06-22T18:11:23.002577Z","end":"2026-06-22T18:11:23.404049Z","steps":["trace[1688861985] 'agreement among raft nodes before linearized reading' (duration: 399.601728ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:23.404513Z","caller":"traceutil/trace.go:171","msg":"trace[1084981333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"493.251125ms","start":"2026-06-22T18:11:22.911223Z","end":"2026-06-22T18:11:23.404474Z","steps":["trace[1084981333] 'agreement among raft nodes before linearized reading' (duration: 490.933732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.404534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.002564Z","time spent":"401.931591ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:23.404581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.911201Z","time spent":"493.36096ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-22T18:11:23.402165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.647195ms","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-06-22T18:11:23.404863Z","caller":"traceutil/trace.go:171","msg":"trace[37391910] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:354; }","duration":"499.048895ms","start":"2026-06-22T18:11:22.903125Z","end":"2026-06-22T18:11:23.402174Z","steps":["trace[37391910] 'agreement among raft nodes before linearized reading' (duration: 498.984582ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:23.404981Z","caller":"traceutil/trace.go:171","msg":"trace[873894568] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"537.348666ms","start":"2026-06-22T18:11:22.867466Z","end":"2026-06-22T18:11:23.404814Z","steps":["trace[873894568] 'agreement among raft nodes before linearized reading' (duration: 534.669676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.404993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.903102Z","time spent":"501.871552ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:23.405103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:22.867448Z","time spent":"537.619529ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:11:23.406055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.991695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-22T18:11:23.406149Z","caller":"traceutil/trace.go:171","msg":"trace[1795235795] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:354; }","duration":"353.117821ms","start":"2026-06-22T18:11:23.053014Z","end":"2026-06-22T18:11:23.406132Z","steps":["trace[1795235795] 'agreement among raft nodes before linearized reading' (duration: 349.164908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:23.406196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.052999Z","time spent":"353.185644ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-22T18:11:24.174908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.777434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:11:24.175007Z","caller":"traceutil/trace.go:171","msg":"trace[2127550964] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"763.538736ms","start":"2026-06-22T18:11:23.41145Z","end":"2026-06-22T18:11:24.174989Z","steps":["trace[2127550964] 'process raft request' (duration: 80.394445ms)","trace[2127550964] 'compare' (duration: 682.394915ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:24.175064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.411416Z","time spent":"763.62051ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:11:24.241865Z","caller":"traceutil/trace.go:171","msg":"trace[397703439] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"830.401359ms","start":"2026-06-22T18:11:23.411423Z","end":"2026-06-22T18:11:24.241824Z","steps":["trace[397703439] 'process raft request' (duration: 830.037641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:24.242112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.411396Z","time spent":"830.569297ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:11:24.242175Z","caller":"traceutil/trace.go:171","msg":"trace[1507058403] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"827.090839ms","start":"2026-06-22T18:11:23.415077Z","end":"2026-06-22T18:11:24.242168Z","steps":["trace[1507058403] 'process raft request' (duration: 826.566833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:24.242293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.415062Z","time spent":"827.147542ms","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:24.241885Z","caller":"traceutil/trace.go:171","msg":"trace[401485313] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"828.040385ms","start":"2026-06-22T18:11:23.413814Z","end":"2026-06-22T18:11:24.241854Z","steps":["trace[401485313] 'process raft request' (duration: 827.751692ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.242303Z","caller":"traceutil/trace.go:171","msg":"trace[2119613790] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"826.551483ms","start":"2026-06-22T18:11:23.415723Z","end":"2026-06-22T18:11:24.242274Z","steps":["trace[2119613790] 'process raft request' (duration: 825.956984ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.242349Z","caller":"traceutil/trace.go:171","msg":"trace[2063418283] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"826.253728ms","start":"2026-06-22T18:11:23.416058Z","end":"2026-06-22T18:11:24.242311Z","steps":["trace[2063418283] 'process raft request' (duration: 825.655269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:24.242425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.415717Z","time spent":"826.641657ms","remote":"127.0.0.1:51448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:24.242448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.416051Z","time spent":"826.349283ms","remote":"127.0.0.1:51452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:11:24.242459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.413802Z","time spent":"828.572561ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:24.242122Z","caller":"traceutil/trace.go:171","msg":"trace[1277237097] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"827.962712ms","start":"2026-06-22T18:11:23.414148Z","end":"2026-06-22T18:11:24.24211Z","steps":["trace[1277237097] 'process raft request' (duration: 827.457157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:24.242591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.414139Z","time spent":"828.420184ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:24.24268Z","caller":"traceutil/trace.go:171","msg":"trace[598398009] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"826.520131ms","start":"2026-06-22T18:11:23.416149Z","end":"2026-06-22T18:11:24.242669Z","steps":["trace[598398009] 'process raft request' (duration: 825.905551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:24.242756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:23.416144Z","time spent":"826.565283ms","remote":"127.0.0.1:51170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:11:24.4932Z","caller":"traceutil/trace.go:171","msg":"trace[918237160] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"244.697513ms","start":"2026-06-22T18:11:24.248481Z","end":"2026-06-22T18:11:24.493178Z","steps":["trace[918237160] 'read index received' (duration: 243.979607ms)","trace[918237160] 'applied index is now lower than readState.Index' (duration: 717.146µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:24.493325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.82866ms","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-06-22T18:11:24.493309Z","caller":"traceutil/trace.go:171","msg":"trace[1426644083] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"245.230929ms","start":"2026-06-22T18:11:24.248042Z","end":"2026-06-22T18:11:24.493273Z","steps":["trace[1426644083] 'process raft request' (duration: 244.489632ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.493349Z","caller":"traceutil/trace.go:171","msg":"trace[1992205558] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:363; }","duration":"244.922303ms","start":"2026-06-22T18:11:24.24842Z","end":"2026-06-22T18:11:24.493342Z","steps":["trace[1992205558] 'agreement among raft nodes before linearized reading' (duration: 244.834969ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.494917Z","caller":"traceutil/trace.go:171","msg":"trace[694837176] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"246.392125ms","start":"2026-06-22T18:11:24.248502Z","end":"2026-06-22T18:11:24.494894Z","steps":["trace[694837176] 'process raft request' (duration: 246.037208ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.495003Z","caller":"traceutil/trace.go:171","msg":"trace[141990398] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"244.165756ms","start":"2026-06-22T18:11:24.250823Z","end":"2026-06-22T18:11:24.494989Z","steps":["trace[141990398] 'process raft request' (duration: 244.106393ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.495168Z","caller":"traceutil/trace.go:171","msg":"trace[1985110489] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"245.364645ms","start":"2026-06-22T18:11:24.249797Z","end":"2026-06-22T18:11:24.495162Z","steps":["trace[1985110489] 'process raft request' (duration: 244.917253ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:24.495518Z","caller":"traceutil/trace.go:171","msg":"trace[1927503572] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"246.925391ms","start":"2026-06-22T18:11:24.248584Z","end":"2026-06-22T18:11:24.495509Z","steps":["trace[1927503572] 'process raft request' (duration: 246.0871ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:25.223256Z","caller":"traceutil/trace.go:171","msg":"trace[1897005627] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"173.860575ms","start":"2026-06-22T18:11:25.049366Z","end":"2026-06-22T18:11:25.223227Z","steps":["trace[1897005627] 'process raft request' (duration: 148.113403ms)","trace[1897005627] 'compare' (duration: 25.617466ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:11:25.247494Z","caller":"traceutil/trace.go:171","msg":"trace[1726458893] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"188.681741ms","start":"2026-06-22T18:11:25.058732Z","end":"2026-06-22T18:11:25.247414Z","steps":["trace[1726458893] 'process raft request' (duration: 188.487832ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:42.477763Z","caller":"traceutil/trace.go:171","msg":"trace[1115593091] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"168.561291ms","start":"2026-06-22T18:11:42.309183Z","end":"2026-06-22T18:11:42.477744Z","steps":["trace[1115593091] 'process raft request' (duration: 168.184322ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.236365Z","caller":"traceutil/trace.go:171","msg":"trace[770954666] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"251.374011ms","start":"2026-06-22T18:11:50.984969Z","end":"2026-06-22T18:11:51.236343Z","steps":["trace[770954666] 'process raft request' (duration: 251.213902ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.243142Z","caller":"traceutil/trace.go:171","msg":"trace[103858761] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"247.919087ms","start":"2026-06-22T18:11:50.995184Z","end":"2026-06-22T18:11:51.243103Z","steps":["trace[103858761] 'process raft request' (duration: 247.695026ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.243385Z","caller":"traceutil/trace.go:171","msg":"trace[1768869105] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"246.157445ms","start":"2026-06-22T18:11:50.997183Z","end":"2026-06-22T18:11:51.24334Z","steps":["trace[1768869105] 'process raft request' (duration: 245.822457ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.243524Z","caller":"traceutil/trace.go:171","msg":"trace[765339490] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"242.270189ms","start":"2026-06-22T18:11:51.001243Z","end":"2026-06-22T18:11:51.243513Z","steps":["trace[765339490] 'process raft request' (duration: 241.803934ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.243826Z","caller":"traceutil/trace.go:171","msg":"trace[794137621] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"240.317746ms","start":"2026-06-22T18:11:51.003498Z","end":"2026-06-22T18:11:51.243816Z","steps":["trace[794137621] 'process raft request' (duration: 239.604627ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.243872Z","caller":"traceutil/trace.go:171","msg":"trace[1672250753] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"238.919042ms","start":"2026-06-22T18:11:51.004942Z","end":"2026-06-22T18:11:51.243861Z","steps":["trace[1672250753] 'process raft request' (duration: 238.210224ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.244041Z","caller":"traceutil/trace.go:171","msg":"trace[751954638] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"238.228806ms","start":"2026-06-22T18:11:51.005736Z","end":"2026-06-22T18:11:51.243965Z","steps":["trace[751954638] 'process raft request' (duration: 237.819303ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.244327Z","caller":"traceutil/trace.go:171","msg":"trace[1240458714] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"238.448527ms","start":"2026-06-22T18:11:51.005865Z","end":"2026-06-22T18:11:51.244314Z","steps":["trace[1240458714] 'process raft request' (duration: 238.297189ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.24454Z","caller":"traceutil/trace.go:171","msg":"trace[1867315722] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"232.354313ms","start":"2026-06-22T18:11:51.012174Z","end":"2026-06-22T18:11:51.244529Z","steps":["trace[1867315722] 'process raft request' (duration: 232.069758ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.244667Z","caller":"traceutil/trace.go:171","msg":"trace[633572261] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"220.277404ms","start":"2026-06-22T18:11:51.024374Z","end":"2026-06-22T18:11:51.244651Z","steps":["trace[633572261] 'process raft request' (duration: 220.086144ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:51.245021Z","caller":"traceutil/trace.go:171","msg":"trace[401058008] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"195.025145ms","start":"2026-06-22T18:11:51.049978Z","end":"2026-06-22T18:11:51.245004Z","steps":["trace[401058008] 'process raft request' (duration: 194.5435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:52.779831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.750855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:11:52.779917Z","caller":"traceutil/trace.go:171","msg":"trace[1872496375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"108.888772ms","start":"2026-06-22T18:11:52.671013Z","end":"2026-06-22T18:11:52.779902Z","steps":["trace[1872496375] 'count revisions from in-memory index tree' (duration: 108.67267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:52.780157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.938687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-06-22T18:11:52.780191Z","caller":"traceutil/trace.go:171","msg":"trace[560029153] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:604; }","duration":"109.99075ms","start":"2026-06-22T18:11:52.670193Z","end":"2026-06-22T18:11:52.780184Z","steps":["trace[560029153] 'range keys from in-memory index tree' (duration: 109.80397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:52.780299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.387867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:11:52.780324Z","caller":"traceutil/trace.go:171","msg":"trace[182793866] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"109.446311ms","start":"2026-06-22T18:11:52.670872Z","end":"2026-06-22T18:11:52.780318Z","steps":["trace[182793866] 'range keys from in-memory index tree' (duration: 109.326814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:52.780133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.7704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:11:52.780431Z","caller":"traceutil/trace.go:171","msg":"trace[1977939618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"104.092716ms","start":"2026-06-22T18:11:52.676331Z","end":"2026-06-22T18:11:52.780424Z","steps":["trace[1977939618] 'range keys from in-memory index tree' (duration: 103.678985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:57.640698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.293732ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-22T18:11:57.640817Z","caller":"traceutil/trace.go:171","msg":"trace[361958803] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"521.105455ms","start":"2026-06-22T18:11:57.11969Z","end":"2026-06-22T18:11:57.640795Z","steps":["trace[361958803] 'read index received' (duration: 170.719198ms)","trace[361958803] 'applied index is now lower than readState.Index' (duration: 350.384417ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:57.641025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.325677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbhl7\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-22T18:11:57.64108Z","caller":"traceutil/trace.go:171","msg":"trace[36498474] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbhl7; range_end:; response_count:1; response_revision:623; }","duration":"521.423463ms","start":"2026-06-22T18:11:57.119641Z","end":"2026-06-22T18:11:57.641064Z","steps":["trace[36498474] 'agreement among raft nodes before linearized reading' (duration: 521.222422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:57.641132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:57.11962Z","time spent":"521.499067ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-kbhl7\" "} {"level":"warn","ts":"2026-06-22T18:11:57.641281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:57.03009Z","time spent":"611.184038ms","remote":"127.0.0.1:51044","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-22T18:11:57.860136Z","caller":"traceutil/trace.go:171","msg":"trace[959057798] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"630.542844ms","start":"2026-06-22T18:11:57.229551Z","end":"2026-06-22T18:11:57.860093Z","steps":["trace[959057798] 'process raft request' (duration: 620.034801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:57.860359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:57.22952Z","time spent":"630.750954ms","remote":"127.0.0.1:51108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:11:57.904897Z","caller":"traceutil/trace.go:171","msg":"trace[404190749] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"251.412978ms","start":"2026-06-22T18:11:57.653456Z","end":"2026-06-22T18:11:57.904869Z","steps":["trace[404190749] 'process raft request' (duration: 251.291612ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:57.904937Z","caller":"traceutil/trace.go:171","msg":"trace[892318407] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"262.30493ms","start":"2026-06-22T18:11:57.642577Z","end":"2026-06-22T18:11:57.904882Z","steps":["trace[892318407] 'process raft request' (duration: 262.058837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:59.175724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.480221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:11:59.175827Z","caller":"traceutil/trace.go:171","msg":"trace[749278878] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"631.042145ms","start":"2026-06-22T18:11:58.544771Z","end":"2026-06-22T18:11:59.175813Z","steps":["trace[749278878] 'read index received' (duration: 98.336983ms)","trace[749278878] 'applied index is now lower than readState.Index' (duration: 532.704232ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:59.175959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.187913ms","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-06-22T18:11:59.175978Z","caller":"traceutil/trace.go:171","msg":"trace[1113792138] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"631.231275ms","start":"2026-06-22T18:11:58.544739Z","end":"2026-06-22T18:11:59.17597Z","steps":["trace[1113792138] 'agreement among raft nodes before linearized reading' (duration: 631.156971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:59.176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:58.544724Z","time spent":"631.270697ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:11:59.176004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.625728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:11:59.176076Z","caller":"traceutil/trace.go:171","msg":"trace[1695097066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"302.743864ms","start":"2026-06-22T18:11:58.873311Z","end":"2026-06-22T18:11:59.176055Z","steps":["trace[1695097066] 'agreement among raft nodes before linearized reading' (duration: 302.624708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:59.176112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:58.87329Z","time spent":"302.815148ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T18:11:59.176072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.96751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T18:11:59.176181Z","caller":"traceutil/trace.go:171","msg":"trace[1176344470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"520.126919ms","start":"2026-06-22T18:11:58.656025Z","end":"2026-06-22T18:11:59.176152Z","steps":["trace[1176344470] 'agreement among raft nodes before linearized reading' (duration: 519.907147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:59.176237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.335024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-22T18:11:59.176237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:58.656006Z","time spent":"520.221054ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T18:11:59.176262Z","caller":"traceutil/trace.go:171","msg":"trace[1101694321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"366.385676ms","start":"2026-06-22T18:11:58.809869Z","end":"2026-06-22T18:11:59.176255Z","steps":["trace[1101694321] 'agreement among raft nodes before linearized reading' (duration: 366.291181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:11:59.176283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:58.809856Z","time spent":"366.422418ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T18:11:59.176377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.811118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:11:59.17641Z","caller":"traceutil/trace.go:171","msg":"trace[531722397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"142.878762ms","start":"2026-06-22T18:11:59.033522Z","end":"2026-06-22T18:11:59.176401Z","steps":["trace[531722397] 'agreement among raft nodes before linearized reading' (duration: 142.737474ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:11:59.177429Z","caller":"traceutil/trace.go:171","msg":"trace[690145042] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.23821265s","start":"2026-06-22T18:11:57.937625Z","end":"2026-06-22T18:11:59.175837Z","steps":["trace[690145042] 'process raft request' (duration: 705.563001ms)","trace[690145042] 'compare' (duration: 532.360773ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:11:59.17752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:11:57.93761Z","time spent":"1.239859238s","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:12:15.293128Z","caller":"traceutil/trace.go:171","msg":"trace[700700792] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"462.303166ms","start":"2026-06-22T18:12:14.830803Z","end":"2026-06-22T18:12:15.293106Z","steps":["trace[700700792] 'read index received' (duration: 462.182338ms)","trace[700700792] 'applied index is now lower than readState.Index' (duration: 119.928µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:12:15.293175Z","caller":"traceutil/trace.go:171","msg":"trace[2069331514] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"556.667288ms","start":"2026-06-22T18:12:14.736468Z","end":"2026-06-22T18:12:15.293136Z","steps":["trace[2069331514] 'process raft request' (duration: 556.510361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.293319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:14.736453Z","time spent":"556.791706ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:12:15.293336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.514442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:12:15.293451Z","caller":"traceutil/trace.go:171","msg":"trace[836150170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"462.677018ms","start":"2026-06-22T18:12:14.830725Z","end":"2026-06-22T18:12:15.293402Z","steps":["trace[836150170] 'agreement among raft nodes before linearized reading' (duration: 462.529431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.293503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:14.830703Z","time spent":"462.792027ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T18:12:15.370364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.060013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:12:15.370467Z","caller":"traceutil/trace.go:171","msg":"trace[407434704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:802; }","duration":"496.195321ms","start":"2026-06-22T18:12:14.874251Z","end":"2026-06-22T18:12:15.370446Z","steps":["trace[407434704] 'agreement among raft nodes before linearized reading' (duration: 496.034914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.370509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:14.87424Z","time spent":"496.261069ms","remote":"127.0.0.1:51034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T18:12:15.370737Z","caller":"traceutil/trace.go:171","msg":"trace[2088379034] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"134.346872ms","start":"2026-06-22T18:12:15.23637Z","end":"2026-06-22T18:12:15.370717Z","steps":["trace[2088379034] 'process raft request' (duration: 104.201864ms)","trace[2088379034] 'compare' (duration: 29.46599ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:12:15.370881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.123865ms","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-06-22T18:12:15.370927Z","caller":"traceutil/trace.go:171","msg":"trace[1823587093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"104.214064ms","start":"2026-06-22T18:12:15.266701Z","end":"2026-06-22T18:12:15.370915Z","steps":["trace[1823587093] 'agreement among raft nodes before linearized reading' (duration: 104.069437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.371096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.132624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-22T18:12:15.371149Z","caller":"traceutil/trace.go:171","msg":"trace[375337875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"108.218762ms","start":"2026-06-22T18:12:15.262918Z","end":"2026-06-22T18:12:15.371137Z","steps":["trace[375337875] 'agreement among raft nodes before linearized reading' (duration: 108.119694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.371156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.813243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:12:15.371215Z","caller":"traceutil/trace.go:171","msg":"trace[383930839] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:802; }","duration":"405.904431ms","start":"2026-06-22T18:12:14.965291Z","end":"2026-06-22T18:12:15.371196Z","steps":["trace[383930839] 'agreement among raft nodes before linearized reading' (duration: 405.780443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:15.371261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:14.965273Z","time spent":"405.97691ms","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-22T18:12:15.371446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.605129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:12:15.371487Z","caller":"traceutil/trace.go:171","msg":"trace[789062956] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:802; }","duration":"261.684777ms","start":"2026-06-22T18:12:15.109793Z","end":"2026-06-22T18:12:15.371478Z","steps":["trace[789062956] 'agreement among raft nodes before linearized reading' (duration: 261.618039ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.772062Z","caller":"traceutil/trace.go:171","msg":"trace[1674911756] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"137.919892ms","start":"2026-06-22T18:12:33.634125Z","end":"2026-06-22T18:12:33.772045Z","steps":["trace[1674911756] 'process raft request' (duration: 137.836642ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.772293Z","caller":"traceutil/trace.go:171","msg":"trace[456827759] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"138.099861ms","start":"2026-06-22T18:12:33.634159Z","end":"2026-06-22T18:12:33.772259Z","steps":["trace[456827759] 'process raft request' (duration: 137.851161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:33.772519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.390331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-79c48d47db\" ","response":"range_response_count:1 size:4876"} {"level":"info","ts":"2026-06-22T18:12:33.772611Z","caller":"traceutil/trace.go:171","msg":"trace[1487117963] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-79c48d47db; range_end:; response_count:1; response_revision:1092; }","duration":"138.507721ms","start":"2026-06-22T18:12:33.634083Z","end":"2026-06-22T18:12:33.772591Z","steps":["trace[1487117963] 'agreement among raft nodes before linearized reading' (duration: 138.296911ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.772895Z","caller":"traceutil/trace.go:171","msg":"trace[1597676940] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"138.77969ms","start":"2026-06-22T18:12:33.634083Z","end":"2026-06-22T18:12:33.772863Z","steps":["trace[1597676940] 'process raft request' (duration: 112.968837ms)","trace[1597676940] 'compare' (duration: 24.799665ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:12:33.772907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.75189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-cainjector-579c9dd7cd\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-22T18:12:33.77307Z","caller":"traceutil/trace.go:171","msg":"trace[951246554] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-cainjector-579c9dd7cd; range_end:; response_count:1; response_revision:1092; }","duration":"138.93329ms","start":"2026-06-22T18:12:33.634111Z","end":"2026-06-22T18:12:33.773044Z","steps":["trace[951246554] 'agreement among raft nodes before linearized reading' (duration: 138.385451ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.901799Z","caller":"traceutil/trace.go:171","msg":"trace[1827489077] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"133.43554ms","start":"2026-06-22T18:12:33.768303Z","end":"2026-06-22T18:12:33.901739Z","steps":["trace[1827489077] 'process raft request' (duration: 104.949611ms)","trace[1827489077] 'compare' (duration: 28.12762ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:12:33.901868Z","caller":"traceutil/trace.go:171","msg":"trace[147866022] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"121.93884ms","start":"2026-06-22T18:12:33.779904Z","end":"2026-06-22T18:12:33.901843Z","steps":["trace[147866022] 'process raft request' (duration: 121.88012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:33.902078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.044352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-cainjector-579c9dd7cd\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-22T18:12:33.90214Z","caller":"traceutil/trace.go:171","msg":"trace[120623966] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-cainjector-579c9dd7cd; range_end:; response_count:1; response_revision:1095; }","duration":"126.149672ms","start":"2026-06-22T18:12:33.775975Z","end":"2026-06-22T18:12:33.902124Z","steps":["trace[120623966] 'agreement among raft nodes before linearized reading' (duration: 125.906783ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.902171Z","caller":"traceutil/trace.go:171","msg":"trace[732444087] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"124.729055ms","start":"2026-06-22T18:12:33.77743Z","end":"2026-06-22T18:12:33.902159Z","steps":["trace[732444087] 'process raft request' (duration: 124.290076ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:33.901826Z","caller":"traceutil/trace.go:171","msg":"trace[1311986498] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"125.788663ms","start":"2026-06-22T18:12:33.776006Z","end":"2026-06-22T18:12:33.901794Z","steps":["trace[1311986498] 'read index received' (duration: 97.215815ms)","trace[1311986498] 'applied index is now lower than readState.Index' (duration: 28.569658ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:12:33.902564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.220512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-79c48d47db\" ","response":"range_response_count:1 size:4876"} {"level":"info","ts":"2026-06-22T18:12:33.902619Z","caller":"traceutil/trace.go:171","msg":"trace[418600813] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-79c48d47db; range_end:; response_count:1; response_revision:1095; }","duration":"126.293182ms","start":"2026-06-22T18:12:33.776312Z","end":"2026-06-22T18:12:33.902605Z","steps":["trace[418600813] 'agreement among raft nodes before linearized reading' (duration: 126.089442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:33.902803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.496813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-79c48d47db-jd8ml\" ","response":"range_response_count:1 size:3966"} {"level":"info","ts":"2026-06-22T18:12:33.902828Z","caller":"traceutil/trace.go:171","msg":"trace[1836747896] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-79c48d47db-jd8ml; range_end:; response_count:1; response_revision:1095; }","duration":"125.522633ms","start":"2026-06-22T18:12:33.777299Z","end":"2026-06-22T18:12:33.902822Z","steps":["trace[1836747896] 'agreement among raft nodes before linearized reading' (duration: 125.433563ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:45.050605Z","caller":"traceutil/trace.go:171","msg":"trace[44312256] linearizableReadLoop","detail":"{readStateIndex:1238; appliedIndex:1237; }","duration":"322.203202ms","start":"2026-06-22T18:12:44.728379Z","end":"2026-06-22T18:12:45.050582Z","steps":["trace[44312256] 'read index received' (duration: 321.979951ms)","trace[44312256] 'applied index is now lower than readState.Index' (duration: 222.361µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:12:45.050662Z","caller":"traceutil/trace.go:171","msg":"trace[2035294119] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"588.147962ms","start":"2026-06-22T18:12:44.462473Z","end":"2026-06-22T18:12:45.050621Z","steps":["trace[2035294119] 'process raft request' (duration: 587.964021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:45.050745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.965183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:12:45.050755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.366053ms","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":"warn","ts":"2026-06-22T18:12:45.050813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.482565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:12:45.050803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:44.462448Z","time spent":"588.270413ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:12:45.050829Z","caller":"traceutil/trace.go:171","msg":"trace[495263032] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1199; }","duration":"322.428803ms","start":"2026-06-22T18:12:44.728367Z","end":"2026-06-22T18:12:45.050796Z","steps":["trace[495263032] 'agreement among raft nodes before linearized reading' (duration: 322.306783ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:12:45.050839Z","caller":"traceutil/trace.go:171","msg":"trace[1880526946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"177.537696ms","start":"2026-06-22T18:12:44.873294Z","end":"2026-06-22T18:12:45.050832Z","steps":["trace[1880526946] 'agreement among raft nodes before linearized reading' (duration: 177.503315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:12:45.050875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:12:44.728314Z","time spent":"322.547764ms","remote":"127.0.0.1:51322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":20,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-22T18:12:45.050777Z","caller":"traceutil/trace.go:171","msg":"trace[984402703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"220.035373ms","start":"2026-06-22T18:12:44.830729Z","end":"2026-06-22T18:12:45.050765Z","steps":["trace[984402703] 'agreement among raft nodes before linearized reading' (duration: 219.980803ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:06.361915Z","caller":"traceutil/trace.go:171","msg":"trace[965313552] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"172.648096ms","start":"2026-06-22T18:13:06.189233Z","end":"2026-06-22T18:13:06.361881Z","steps":["trace[965313552] 'process raft request' (duration: 172.373391ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:06.362002Z","caller":"traceutil/trace.go:171","msg":"trace[1568919845] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"128.881019ms","start":"2026-06-22T18:13:06.233086Z","end":"2026-06-22T18:13:06.361967Z","steps":["trace[1568919845] 'process raft request' (duration: 128.711366ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:06.87724Z","caller":"traceutil/trace.go:171","msg":"trace[1736150315] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"247.403669ms","start":"2026-06-22T18:13:06.629818Z","end":"2026-06-22T18:13:06.877221Z","steps":["trace[1736150315] 'process raft request' (duration: 156.711726ms)","trace[1736150315] 'compare' (duration: 90.177103ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:13:07.189857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.998297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:13:07.19038Z","caller":"traceutil/trace.go:171","msg":"trace[2042251849] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"252.565149ms","start":"2026-06-22T18:13:06.937777Z","end":"2026-06-22T18:13:07.190343Z","steps":["trace[2042251849] 'process raft request' (duration: 104.9538ms)","trace[2042251849] 'compare' (duration: 146.734953ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:13:07.190561Z","caller":"traceutil/trace.go:171","msg":"trace[1116516825] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1482; }","duration":"163.773669ms","start":"2026-06-22T18:13:07.026764Z","end":"2026-06-22T18:13:07.190537Z","steps":["trace[1116516825] 'read index received' (duration: 15.978937ms)","trace[1116516825] 'applied index is now lower than readState.Index' (duration: 147.793252ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:13:07.190681Z","caller":"traceutil/trace.go:171","msg":"trace[328656346] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"224.221863ms","start":"2026-06-22T18:13:06.966358Z","end":"2026-06-22T18:13:07.19058Z","steps":["trace[328656346] 'process raft request' (duration: 223.923048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:07.190982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.191288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T18:13:07.191063Z","caller":"traceutil/trace.go:171","msg":"trace[751073088] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1437; }","duration":"164.316629ms","start":"2026-06-22T18:13:07.026717Z","end":"2026-06-22T18:13:07.191034Z","steps":["trace[751073088] 'agreement among raft nodes before linearized reading' (duration: 164.022894ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:07.191532Z","caller":"traceutil/trace.go:171","msg":"trace[1947916911] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"185.6783ms","start":"2026-06-22T18:13:07.005795Z","end":"2026-06-22T18:13:07.191473Z","steps":["trace[1947916911] 'process raft request' (duration: 184.681211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:07.193853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.69274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:13:07.193923Z","caller":"traceutil/trace.go:171","msg":"trace[598840292] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1438; }","duration":"162.816552ms","start":"2026-06-22T18:13:07.031087Z","end":"2026-06-22T18:13:07.193904Z","steps":["trace[598840292] 'agreement among raft nodes before linearized reading' (duration: 162.660159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:07.445514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.91466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:13:07.445741Z","caller":"traceutil/trace.go:171","msg":"trace[421257126] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"158.377869ms","start":"2026-06-22T18:13:07.287344Z","end":"2026-06-22T18:13:07.445722Z","steps":["trace[421257126] 'process raft request' (duration: 158.315628ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:07.445755Z","caller":"traceutil/trace.go:171","msg":"trace[2016706083] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"240.628307ms","start":"2026-06-22T18:13:07.205093Z","end":"2026-06-22T18:13:07.445721Z","steps":["trace[2016706083] 'process raft request' (duration: 135.427291ms)","trace[2016706083] 'compare' (duration: 104.767228ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:13:07.446067Z","caller":"traceutil/trace.go:171","msg":"trace[2099835365] linearizableReadLoop","detail":"{readStateIndex:1489; appliedIndex:1488; }","duration":"207.024648ms","start":"2026-06-22T18:13:07.239029Z","end":"2026-06-22T18:13:07.446054Z","steps":["trace[2099835365] 'read index received' (duration: 101.583188ms)","trace[2099835365] 'applied index is now lower than readState.Index' (duration: 105.43965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:13:07.446192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.16396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-22T18:13:07.446223Z","caller":"traceutil/trace.go:171","msg":"trace[2081493964] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1441; }","duration":"207.254233ms","start":"2026-06-22T18:13:07.238961Z","end":"2026-06-22T18:13:07.446216Z","steps":["trace[2081493964] 'agreement among raft nodes before linearized reading' (duration: 207.141251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:35.696822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.049435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8825a01b-3ea7-4a1d-b407-8bcf496f3fe8\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-22T18:13:35.696914Z","caller":"traceutil/trace.go:171","msg":"trace[2062708796] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8825a01b-3ea7-4a1d-b407-8bcf496f3fe8; range_end:; response_count:1; response_revision:1888; }","duration":"529.193949ms","start":"2026-06-22T18:13:35.1677Z","end":"2026-06-22T18:13:35.696894Z","steps":["trace[2062708796] 'range keys from in-memory index tree' (duration: 528.831318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:35.696961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.16768Z","time spent":"529.27237ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8825a01b-3ea7-4a1d-b407-8bcf496f3fe8\" "} {"level":"info","ts":"2026-06-22T18:13:35.700449Z","caller":"traceutil/trace.go:171","msg":"trace[1997560422] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"102.540754ms","start":"2026-06-22T18:13:35.597886Z","end":"2026-06-22T18:13:35.700426Z","steps":["trace[1997560422] 'read index received' (duration: 102.342578ms)","trace[1997560422] 'applied index is now lower than readState.Index' (duration: 197.316µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:13:35.700517Z","caller":"traceutil/trace.go:171","msg":"trace[2137121885] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"412.289998ms","start":"2026-06-22T18:13:35.288205Z","end":"2026-06-22T18:13:35.700495Z","steps":["trace[2137121885] 'process raft request' (duration: 412.080132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:35.700691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.28818Z","time spent":"412.439232ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:13:35.700694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.811681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8825a01b-3ea7-4a1d-b407-8bcf496f3fe8\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-22T18:13:35.70087Z","caller":"traceutil/trace.go:171","msg":"trace[1913648464] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8825a01b-3ea7-4a1d-b407-8bcf496f3fe8; range_end:; response_count:1; response_revision:1889; }","duration":"103.11479ms","start":"2026-06-22T18:13:35.59774Z","end":"2026-06-22T18:13:35.700855Z","steps":["trace[1913648464] 'agreement among raft nodes before linearized reading' (duration: 102.801471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.356991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.456596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:13:36.357197Z","caller":"traceutil/trace.go:171","msg":"trace[1170366506] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"650.563941ms","start":"2026-06-22T18:13:35.706601Z","end":"2026-06-22T18:13:36.357165Z","steps":["trace[1170366506] 'process raft request' (duration: 148.863787ms)","trace[1170366506] 'compare' (duration: 501.23376ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:13:36.357248Z","caller":"traceutil/trace.go:171","msg":"trace[778183926] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"526.75364ms","start":"2026-06-22T18:13:35.830477Z","end":"2026-06-22T18:13:36.357231Z","steps":["trace[778183926] 'process raft request' (duration: 526.652097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.357314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.830453Z","time spent":"526.830403ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:13:36.357371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.706584Z","time spent":"650.692105ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:13:36.357396Z","caller":"traceutil/trace.go:171","msg":"trace[2079687608] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"634.736153ms","start":"2026-06-22T18:13:35.722643Z","end":"2026-06-22T18:13:36.357379Z","steps":["trace[2079687608] 'read index received' (duration: 132.833783ms)","trace[2079687608] 'applied index is now lower than readState.Index' (duration: 501.90076ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:13:36.357576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.084222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:13:36.357592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.293242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-22T18:13:36.357595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.795155ms","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-06-22T18:13:36.357629Z","caller":"traceutil/trace.go:171","msg":"trace[1246223933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1891; }","duration":"411.350004ms","start":"2026-06-22T18:13:35.946267Z","end":"2026-06-22T18:13:36.357617Z","steps":["trace[1246223933] 'agreement among raft nodes before linearized reading' (duration: 411.24026ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:36.357632Z","caller":"traceutil/trace.go:171","msg":"trace[1907283075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1891; }","duration":"352.881287ms","start":"2026-06-22T18:13:36.004742Z","end":"2026-06-22T18:13:36.357623Z","steps":["trace[1907283075] 'agreement among raft nodes before linearized reading' (duration: 352.767883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.357658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.946256Z","time spent":"411.396545ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-22T18:13:36.35766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:36.004718Z","time spent":"352.935989ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:13:36.357674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.421052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-22T18:13:36.357674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.0134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-22T18:13:36.357704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.006183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-22T18:13:36.357627Z","caller":"traceutil/trace.go:171","msg":"trace[1987949085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1891; }","duration":"485.203075ms","start":"2026-06-22T18:13:35.87241Z","end":"2026-06-22T18:13:36.357613Z","steps":["trace[1987949085] 'agreement among raft nodes before linearized reading' (duration: 485.097042ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:36.357735Z","caller":"traceutil/trace.go:171","msg":"trace[837117500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1891; }","duration":"353.534076ms","start":"2026-06-22T18:13:36.004185Z","end":"2026-06-22T18:13:36.357719Z","steps":["trace[837117500] 'agreement among raft nodes before linearized reading' (duration: 353.368641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.357737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.989219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:13:36.357747Z","caller":"traceutil/trace.go:171","msg":"trace[487779819] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1891; }","duration":"635.123434ms","start":"2026-06-22T18:13:35.722606Z","end":"2026-06-22T18:13:36.35773Z","steps":["trace[487779819] 'agreement among raft nodes before linearized reading' (duration: 634.841986ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:36.357744Z","caller":"traceutil/trace.go:171","msg":"trace[31827305] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1891; }","duration":"422.082165ms","start":"2026-06-22T18:13:35.935651Z","end":"2026-06-22T18:13:36.357733Z","steps":["trace[31827305] 'agreement among raft nodes before linearized reading' (duration: 421.935941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.357764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:36.004165Z","time spent":"353.593868ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-22T18:13:36.357777Z","caller":"traceutil/trace.go:171","msg":"trace[2050941181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1891; }","duration":"425.118043ms","start":"2026-06-22T18:13:35.932648Z","end":"2026-06-22T18:13:36.357766Z","steps":["trace[2050941181] 'agreement among raft nodes before linearized reading' (duration: 424.999359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:13:36.357793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.935631Z","time spent":"422.153827ms","remote":"127.0.0.1:59104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-22T18:13:36.357792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.722594Z","time spent":"635.188395ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-22T18:13:36.357816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.932627Z","time spent":"425.179505ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T18:13:36.357804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:13:35.872381Z","time spent":"485.38517ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T18:13:46.819633Z","caller":"traceutil/trace.go:171","msg":"trace[638468110] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"195.57033ms","start":"2026-06-22T18:13:46.624035Z","end":"2026-06-22T18:13:46.819605Z","steps":["trace[638468110] 'process raft request' (duration: 195.408655ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:13:46.888518Z","caller":"traceutil/trace.go:171","msg":"trace[198391606] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"123.807448ms","start":"2026-06-22T18:13:46.764684Z","end":"2026-06-22T18:13:46.888491Z","steps":["trace[198391606] 'process raft request' (duration: 123.667683ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:14:03.589637Z","caller":"traceutil/trace.go:171","msg":"trace[479097286] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"147.824239ms","start":"2026-06-22T18:14:03.441778Z","end":"2026-06-22T18:14:03.589602Z","steps":["trace[479097286] 'process raft request' (duration: 147.639182ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:14:04.735717Z","caller":"traceutil/trace.go:171","msg":"trace[1547028173] linearizableReadLoop","detail":"{readStateIndex:2182; appliedIndex:2181; }","duration":"235.140315ms","start":"2026-06-22T18:14:04.500551Z","end":"2026-06-22T18:14:04.735691Z","steps":["trace[1547028173] 'read index received' (duration: 148.409577ms)","trace[1547028173] 'applied index is now lower than readState.Index' (duration: 86.729428ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:14:04.735826Z","caller":"traceutil/trace.go:171","msg":"trace[1055024465] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"236.171301ms","start":"2026-06-22T18:14:04.499623Z","end":"2026-06-22T18:14:04.735794Z","steps":["trace[1055024465] 'process raft request' (duration: 149.437424ms)","trace[1055024465] 'compare' (duration: 86.437507ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:14:04.735977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.418595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T18:14:04.736024Z","caller":"traceutil/trace.go:171","msg":"trace[1758888982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2099; }","duration":"235.512258ms","start":"2026-06-22T18:14:04.500502Z","end":"2026-06-22T18:14:04.736014Z","steps":["trace[1758888982] 'agreement among raft nodes before linearized reading' (duration: 235.349192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:04.736487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.553373ms","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-06-22T18:14:04.736529Z","caller":"traceutil/trace.go:171","msg":"trace[730209881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2099; }","duration":"215.637546ms","start":"2026-06-22T18:14:04.520882Z","end":"2026-06-22T18:14:04.736519Z","steps":["trace[730209881] 'agreement among raft nodes before linearized reading' (duration: 215.4638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:04.736558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.809973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-22T18:14:04.736642Z","caller":"traceutil/trace.go:171","msg":"trace[1716397397] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"138.941438ms","start":"2026-06-22T18:14:04.597678Z","end":"2026-06-22T18:14:04.73662Z","steps":["trace[1716397397] 'agreement among raft nodes before linearized reading' (duration: 138.645707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:04.736642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.734716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:14:04.736721Z","caller":"traceutil/trace.go:171","msg":"trace[913515360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"235.8479ms","start":"2026-06-22T18:14:04.500855Z","end":"2026-06-22T18:14:04.736703Z","steps":["trace[913515360] 'agreement among raft nodes before linearized reading' (duration: 235.607711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:05.272309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.924922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:14:05.27242Z","caller":"traceutil/trace.go:171","msg":"trace[1499671027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2102; }","duration":"399.080068ms","start":"2026-06-22T18:14:04.873323Z","end":"2026-06-22T18:14:05.272403Z","steps":["trace[1499671027] 'range keys from in-memory index tree' (duration: 398.828579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:05.272462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:04.873303Z","time spent":"399.14678ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T18:14:05.272877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.353743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:14:05.273027Z","caller":"traceutil/trace.go:171","msg":"trace[1836948470] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"331.887291ms","start":"2026-06-22T18:14:04.941126Z","end":"2026-06-22T18:14:05.273013Z","steps":["trace[1836948470] 'process raft request' (duration: 331.827889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:05.273091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:04.941113Z","time spent":"331.947763ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:05.273113Z","caller":"traceutil/trace.go:171","msg":"trace[374029764] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"396.489416ms","start":"2026-06-22T18:14:04.876594Z","end":"2026-06-22T18:14:05.273083Z","steps":["trace[374029764] 'process raft request' (duration: 33.865243ms)","trace[374029764] 'compare' (duration: 361.797692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:14:05.273442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:04.876583Z","time spent":"396.778967ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:05.333085Z","caller":"traceutil/trace.go:171","msg":"trace[41932779] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"387.857377ms","start":"2026-06-22T18:14:04.945194Z","end":"2026-06-22T18:14:05.333052Z","steps":["trace[41932779] 'process raft request' (duration: 387.705752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:05.333248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:04.945168Z","time spent":"387.993372ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:06.118846Z","caller":"traceutil/trace.go:171","msg":"trace[715464458] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"257.746942ms","start":"2026-06-22T18:14:05.861057Z","end":"2026-06-22T18:14:06.118804Z","steps":["trace[715464458] 'process raft request' (duration: 257.545085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:06.80236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.691955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:14:06.802483Z","caller":"traceutil/trace.go:171","msg":"trace[1648125732] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2190; }","duration":"316.594918ms","start":"2026-06-22T18:14:06.485867Z","end":"2026-06-22T18:14:06.802462Z","steps":["trace[1648125732] 'read index received' (duration: 68.628353ms)","trace[1648125732] 'applied index is now lower than readState.Index' (duration: 247.964625ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:14:06.802628Z","caller":"traceutil/trace.go:171","msg":"trace[1697205842] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"414.479522ms","start":"2026-06-22T18:14:06.388117Z","end":"2026-06-22T18:14:06.802597Z","steps":["trace[1697205842] 'process raft request' (duration: 166.434464ms)","trace[1697205842] 'compare' (duration: 247.381153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:14:06.802773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.388084Z","time spent":"414.617257ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:14:06.802778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.90146ms","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-06-22T18:14:06.802832Z","caller":"traceutil/trace.go:171","msg":"trace[325823647] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2108; }","duration":"317.001283ms","start":"2026-06-22T18:14:06.485816Z","end":"2026-06-22T18:14:06.802817Z","steps":["trace[325823647] 'agreement among raft nodes before linearized reading' (duration: 316.776665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:06.802888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.485776Z","time spent":"317.098357ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-22T18:14:07.20107Z","caller":"traceutil/trace.go:171","msg":"trace[1248396686] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"391.861849ms","start":"2026-06-22T18:14:06.809183Z","end":"2026-06-22T18:14:07.201044Z","steps":["trace[1248396686] 'process raft request' (duration: 356.296025ms)","trace[1248396686] 'compare' (duration: 35.069996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:14:07.201344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.809168Z","time spent":"392.047745ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:07.201392Z","caller":"traceutil/trace.go:171","msg":"trace[23370067] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"392.17068ms","start":"2026-06-22T18:14:06.809175Z","end":"2026-06-22T18:14:07.201346Z","steps":["trace[23370067] 'process raft request' (duration: 391.801556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:07.201557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.809138Z","time spent":"392.332595ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:07.201641Z","caller":"traceutil/trace.go:171","msg":"trace[275221860] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"391.762075ms","start":"2026-06-22T18:14:06.809868Z","end":"2026-06-22T18:14:07.20163Z","steps":["trace[275221860] 'process raft request' (duration: 391.332029ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:14:07.201713Z","caller":"traceutil/trace.go:171","msg":"trace[1579248179] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2191; }","duration":"329.335265ms","start":"2026-06-22T18:14:06.872289Z","end":"2026-06-22T18:14:07.201624Z","steps":["trace[1579248179] 'read index received' (duration: 4.336846ms)","trace[1579248179] 'applied index is now lower than readState.Index' (duration: 324.996809ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:14:07.20154Z","caller":"traceutil/trace.go:171","msg":"trace[605311441] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"392.257133ms","start":"2026-06-22T18:14:06.809262Z","end":"2026-06-22T18:14:07.201519Z","steps":["trace[605311441] 'process raft request' (duration: 391.874039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:07.201832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.80986Z","time spent":"391.925661ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:14:07.20189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.588704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:14:07.201931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.809252Z","time spent":"392.631116ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:14:07.201968Z","caller":"traceutil/trace.go:171","msg":"trace[85004695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2113; }","duration":"329.719828ms","start":"2026-06-22T18:14:06.872231Z","end":"2026-06-22T18:14:07.20195Z","steps":["trace[85004695] 'agreement among raft nodes before linearized reading' (duration: 329.541692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:07.202016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:14:06.872208Z","time spent":"329.800291ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T18:14:07.202209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.691627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:14:07.202275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.954068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:14:07.20234Z","caller":"traceutil/trace.go:171","msg":"trace[438728666] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2113; }","duration":"168.069243ms","start":"2026-06-22T18:14:07.034258Z","end":"2026-06-22T18:14:07.202327Z","steps":["trace[438728666] 'agreement among raft nodes before linearized reading' (duration: 167.957239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:14:07.202463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.642038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T18:14:07.202262Z","caller":"traceutil/trace.go:171","msg":"trace[574843868] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2113; }","duration":"269.758299ms","start":"2026-06-22T18:14:06.932491Z","end":"2026-06-22T18:14:07.20225Z","steps":["trace[574843868] 'agreement among raft nodes before linearized reading' (duration: 269.665556ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:14:07.202502Z","caller":"traceutil/trace.go:171","msg":"trace[900494304] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:2113; }","duration":"172.710821ms","start":"2026-06-22T18:14:07.029781Z","end":"2026-06-22T18:14:07.202492Z","steps":["trace[900494304] 'agreement among raft nodes before linearized reading' (duration: 172.548675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:16.715363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.970268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:15:16.715447Z","caller":"traceutil/trace.go:171","msg":"trace[893100259] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2588; }","duration":"183.072253ms","start":"2026-06-22T18:15:16.532358Z","end":"2026-06-22T18:15:16.71543Z","steps":["trace[893100259] 'count revisions from in-memory index tree' (duration: 182.880845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:52.048407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.217712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:15:52.048833Z","caller":"traceutil/trace.go:171","msg":"trace[371797338] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"363.205883ms","start":"2026-06-22T18:15:51.68559Z","end":"2026-06-22T18:15:52.048795Z","steps":["trace[371797338] 'process raft request' (duration: 150.513609ms)","trace[371797338] 'compare' (duration: 212.103077ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:15:52.04887Z","caller":"traceutil/trace.go:171","msg":"trace[452203833] transaction","detail":"{read_only:false; response_revision:2783; number_of_response:1; }","duration":"194.175754ms","start":"2026-06-22T18:15:51.854675Z","end":"2026-06-22T18:15:52.048851Z","steps":["trace[452203833] 'process raft request' (duration: 194.1035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:52.049007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:15:51.685574Z","time spent":"363.338898ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:15:52.049147Z","caller":"traceutil/trace.go:171","msg":"trace[1733493561] linearizableReadLoop","detail":"{readStateIndex:2889; appliedIndex:2888; }","duration":"345.487048ms","start":"2026-06-22T18:15:51.703648Z","end":"2026-06-22T18:15:52.049135Z","steps":["trace[1733493561] 'read index received' (duration: 132.519181ms)","trace[1733493561] 'applied index is now lower than readState.Index' (duration: 212.966397ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:15:52.049394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.74835ms","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-06-22T18:15:52.049441Z","caller":"traceutil/trace.go:171","msg":"trace[1903024056] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2783; }","duration":"345.833505ms","start":"2026-06-22T18:15:51.703595Z","end":"2026-06-22T18:15:52.049429Z","steps":["trace[1903024056] 'agreement among raft nodes before linearized reading' (duration: 345.671277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:52.049482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.314959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-22T18:15:52.049542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.020908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:15:52.049577Z","caller":"traceutil/trace.go:171","msg":"trace[314683374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2783; }","duration":"176.094042ms","start":"2026-06-22T18:15:51.873474Z","end":"2026-06-22T18:15:52.049568Z","steps":["trace[314683374] 'agreement among raft nodes before linearized reading' (duration: 176.04625ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:15:52.049701Z","caller":"traceutil/trace.go:171","msg":"trace[1909860350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2783; }","duration":"341.459075ms","start":"2026-06-22T18:15:51.708078Z","end":"2026-06-22T18:15:52.049537Z","steps":["trace[1909860350] 'agreement among raft nodes before linearized reading' (duration: 341.244496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:52.049823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:15:51.708066Z","time spent":"341.707166ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-22T18:15:52.049474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:15:51.703574Z","time spent":"345.892227ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-22T18:15:52.050005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.857133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-22T18:15:52.05004Z","caller":"traceutil/trace.go:171","msg":"trace[1840363012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2783; }","duration":"341.906276ms","start":"2026-06-22T18:15:51.708125Z","end":"2026-06-22T18:15:52.050031Z","steps":["trace[1840363012] 'agreement among raft nodes before linearized reading' (duration: 341.702146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:15:52.050182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:15:51.708119Z","time spent":"342.055192ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-22T18:15:52.200842Z","caller":"traceutil/trace.go:171","msg":"trace[2066001407] transaction","detail":"{read_only:false; response_revision:2784; number_of_response:1; }","duration":"147.13263ms","start":"2026-06-22T18:15:52.05368Z","end":"2026-06-22T18:15:52.200813Z","steps":["trace[2066001407] 'process raft request' (duration: 146.969743ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:15:52.206464Z","caller":"traceutil/trace.go:171","msg":"trace[1047468468] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"150.88897ms","start":"2026-06-22T18:15:52.055555Z","end":"2026-06-22T18:15:52.206444Z","steps":["trace[1047468468] 'process raft request' (duration: 150.749134ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:15:52.206662Z","caller":"traceutil/trace.go:171","msg":"trace[1180175987] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"151.026457ms","start":"2026-06-22T18:15:52.055615Z","end":"2026-06-22T18:15:52.206641Z","steps":["trace[1180175987] 'process raft request' (duration: 150.790187ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:10.842688Z","caller":"traceutil/trace.go:171","msg":"trace[1767094413] transaction","detail":"{read_only:false; response_revision:3602; number_of_response:1; }","duration":"109.144957ms","start":"2026-06-22T18:18:10.73352Z","end":"2026-06-22T18:18:10.842665Z","steps":["trace[1767094413] 'process raft request' (duration: 109.013415ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:01.076823Z","caller":"traceutil/trace.go:171","msg":"trace[2038544704] transaction","detail":"{read_only:false; response_revision:3941; number_of_response:1; }","duration":"132.871664ms","start":"2026-06-22T18:19:00.943916Z","end":"2026-06-22T18:19:01.076788Z","steps":["trace[2038544704] 'process raft request' (duration: 132.616837ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:01.42034Z","caller":"traceutil/trace.go:171","msg":"trace[941490655] transaction","detail":"{read_only:false; response_revision:3944; number_of_response:1; }","duration":"121.402614ms","start":"2026-06-22T18:19:01.298908Z","end":"2026-06-22T18:19:01.42031Z","steps":["trace[941490655] 'process raft request' (duration: 99.649204ms)","trace[941490655] 'compare' (duration: 21.575316ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:01.420362Z","caller":"traceutil/trace.go:171","msg":"trace[620549474] transaction","detail":"{read_only:false; response_revision:3945; number_of_response:1; }","duration":"105.215866ms","start":"2026-06-22T18:19:01.315125Z","end":"2026-06-22T18:19:01.42034Z","steps":["trace[620549474] 'process raft request' (duration: 105.115824ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:27.471204Z","caller":"traceutil/trace.go:171","msg":"trace[712976506] transaction","detail":"{read_only:false; response_revision:4106; number_of_response:1; }","duration":"152.711289ms","start":"2026-06-22T18:19:27.318448Z","end":"2026-06-22T18:19:27.471159Z","steps":["trace[712976506] 'process raft request' (duration: 148.408925ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:43.4724Z","caller":"traceutil/trace.go:171","msg":"trace[96486278] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"137.61336ms","start":"2026-06-22T18:19:43.334766Z","end":"2026-06-22T18:19:43.47238Z","steps":["trace[96486278] 'process raft request' (duration: 137.481747ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:43.484668Z","caller":"traceutil/trace.go:171","msg":"trace[2107758128] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"145.647493ms","start":"2026-06-22T18:19:43.338996Z","end":"2026-06-22T18:19:43.484643Z","steps":["trace[2107758128] 'process raft request' (duration: 145.473498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:48.267684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.499494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-22T18:19:48.267815Z","caller":"traceutil/trace.go:171","msg":"trace[1661819988] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a; range_end:; response_count:1; response_revision:4792; }","duration":"169.637069ms","start":"2026-06-22T18:19:48.098148Z","end":"2026-06-22T18:19:48.267785Z","steps":["trace[1661819988] 'range keys from in-memory index tree' (duration: 169.32898ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:48.69886Z","caller":"traceutil/trace.go:171","msg":"trace[2050196287] linearizableReadLoop","detail":"{readStateIndex:4978; appliedIndex:4977; }","duration":"156.359263ms","start":"2026-06-22T18:19:48.542477Z","end":"2026-06-22T18:19:48.698836Z","steps":["trace[2050196287] 'read index received' (duration: 156.137826ms)","trace[2050196287] 'applied index is now lower than readState.Index' (duration: 220.557µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:48.698914Z","caller":"traceutil/trace.go:171","msg":"trace[843265892] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"159.18565ms","start":"2026-06-22T18:19:48.539685Z","end":"2026-06-22T18:19:48.698871Z","steps":["trace[843265892] 'process raft request' (duration: 159.019065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:48.699147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.644541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-22T18:19:48.699195Z","caller":"traceutil/trace.go:171","msg":"trace[2126463347] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a; range_end:; response_count:1; response_revision:4793; }","duration":"156.739174ms","start":"2026-06-22T18:19:48.542443Z","end":"2026-06-22T18:19:48.699182Z","steps":["trace[2126463347] 'agreement among raft nodes before linearized reading' (duration: 156.485997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.071351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.476547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:19:49.071504Z","caller":"traceutil/trace.go:171","msg":"trace[832556864] linearizableReadLoop","detail":"{readStateIndex:4982; appliedIndex:4981; }","duration":"199.067004ms","start":"2026-06-22T18:19:48.872415Z","end":"2026-06-22T18:19:49.071482Z","steps":["trace[832556864] 'read index received' (duration: 31.886945ms)","trace[832556864] 'applied index is now lower than readState.Index' (duration: 167.177949ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:49.071569Z","caller":"traceutil/trace.go:171","msg":"trace[305717011] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"223.280225ms","start":"2026-06-22T18:19:48.848261Z","end":"2026-06-22T18:19:49.071541Z","steps":["trace[305717011] 'process raft request' (duration: 56.134987ms)","trace[305717011] 'compare' (duration: 166.105466ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:19:49.071646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.229709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:19:49.071689Z","caller":"traceutil/trace.go:171","msg":"trace[1385680439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4797; }","duration":"199.302631ms","start":"2026-06-22T18:19:48.872373Z","end":"2026-06-22T18:19:49.071675Z","steps":["trace[1385680439] 'agreement among raft nodes before linearized reading' (duration: 199.228239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.071971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.740034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-22T18:19:49.072014Z","caller":"traceutil/trace.go:171","msg":"trace[1068012818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4797; }","duration":"181.831107ms","start":"2026-06-22T18:19:48.890172Z","end":"2026-06-22T18:19:49.072003Z","steps":["trace[1068012818] 'agreement among raft nodes before linearized reading' (duration: 181.707873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.708127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.54414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-06-22T18:19:49.708264Z","caller":"traceutil/trace.go:171","msg":"trace[1027208284] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a; range_end:; response_count:1; response_revision:4798; }","duration":"436.673475ms","start":"2026-06-22T18:19:49.271513Z","end":"2026-06-22T18:19:49.708187Z","steps":["trace[1027208284] 'range keys from in-memory index tree' (duration: 436.378366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.708316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.271491Z","time spent":"436.812388ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3782,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a2312c59-4e99-4088-b72b-d2d115323c9a\" "} {"level":"info","ts":"2026-06-22T18:19:49.897523Z","caller":"traceutil/trace.go:171","msg":"trace[860486122] linearizableReadLoop","detail":"{readStateIndex:4984; appliedIndex:4983; }","duration":"351.280055ms","start":"2026-06-22T18:19:49.54622Z","end":"2026-06-22T18:19:49.8975Z","steps":["trace[860486122] 'read index received' (duration: 351.196202ms)","trace[860486122] 'applied index is now lower than readState.Index' (duration: 82.712µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:49.897586Z","caller":"traceutil/trace.go:171","msg":"trace[600829417] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"438.81723ms","start":"2026-06-22T18:19:49.458738Z","end":"2026-06-22T18:19:49.897556Z","steps":["trace[600829417] 'process raft request' (duration: 438.617204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.897735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.458718Z","time spent":"438.940524ms","remote":"127.0.0.1:51178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10960,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:49.897852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.620795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8\" ","response":"range_response_count:1 size:11256"} {"level":"info","ts":"2026-06-22T18:19:49.897968Z","caller":"traceutil/trace.go:171","msg":"trace[1341898463] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8; range_end:; response_count:1; response_revision:4799; }","duration":"351.749849ms","start":"2026-06-22T18:19:49.546172Z","end":"2026-06-22T18:19:49.897922Z","steps":["trace[1341898463] 'agreement among raft nodes before linearized reading' (duration: 351.44534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:49.898051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.546143Z","time spent":"351.859753ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11279,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8\" "} {"level":"info","ts":"2026-06-22T18:19:50.114366Z","caller":"traceutil/trace.go:171","msg":"trace[356362734] linearizableReadLoop","detail":"{readStateIndex:4987; appliedIndex:4984; }","duration":"216.748107ms","start":"2026-06-22T18:19:49.897593Z","end":"2026-06-22T18:19:50.114341Z","steps":["trace[356362734] 'read index received' (duration: 216.623504ms)","trace[356362734] 'applied index is now lower than readState.Index' (duration: 123.883µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:50.114516Z","caller":"traceutil/trace.go:171","msg":"trace[1416314973] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"295.301556ms","start":"2026-06-22T18:19:49.819171Z","end":"2026-06-22T18:19:50.114473Z","steps":["trace[1416314973] 'process raft request' (duration: 295.134391ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:50.114615Z","caller":"traceutil/trace.go:171","msg":"trace[1712996033] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"567.203867ms","start":"2026-06-22T18:19:49.547348Z","end":"2026-06-22T18:19:50.114552Z","steps":["trace[1712996033] 'process raft request' (duration: 566.738913ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:50.114687Z","caller":"traceutil/trace.go:171","msg":"trace[1387682379] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"464.088584ms","start":"2026-06-22T18:19:49.650584Z","end":"2026-06-22T18:19:50.114673Z","steps":["trace[1387682379] 'process raft request' (duration: 463.666082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.114702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.811995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-22T18:19:50.11476Z","caller":"traceutil/trace.go:171","msg":"trace[1065908488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4802; }","duration":"386.926519ms","start":"2026-06-22T18:19:49.72782Z","end":"2026-06-22T18:19:50.114747Z","steps":["trace[1065908488] 'agreement among raft nodes before linearized reading' (duration: 386.740542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.114791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.727802Z","time spent":"386.983701ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:50.114794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.650566Z","time spent":"464.156227ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:50.114781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.109182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-22T18:19:50.114831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.799497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:19:50.114923Z","caller":"traceutil/trace.go:171","msg":"trace[1637241598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4802; }","duration":"241.950121ms","start":"2026-06-22T18:19:49.872952Z","end":"2026-06-22T18:19:50.114902Z","steps":["trace[1637241598] 'agreement among raft nodes before linearized reading' (duration: 241.780696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.114821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.547323Z","time spent":"567.392934ms","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:19:50.114922Z","caller":"traceutil/trace.go:171","msg":"trace[477031924] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4802; }","duration":"413.248736ms","start":"2026-06-22T18:19:49.701597Z","end":"2026-06-22T18:19:50.114846Z","steps":["trace[477031924] 'agreement among raft nodes before linearized reading' (duration: 412.987727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.11499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.701575Z","time spent":"413.404051ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:50.115041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.252939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-22T18:19:50.115125Z","caller":"traceutil/trace.go:171","msg":"trace[1806647037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4802; }","duration":"432.371283ms","start":"2026-06-22T18:19:49.682739Z","end":"2026-06-22T18:19:50.115111Z","steps":["trace[1806647037] 'agreement among raft nodes before linearized reading' (duration: 432.097264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.115195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.682724Z","time spent":"432.459325ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:50.11536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.764794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-22T18:19:50.115411Z","caller":"traceutil/trace.go:171","msg":"trace[232171949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4802; }","duration":"551.858616ms","start":"2026-06-22T18:19:49.56354Z","end":"2026-06-22T18:19:50.115399Z","steps":["trace[232171949] 'agreement among raft nodes before linearized reading' (duration: 550.897806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:50.115446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:49.563518Z","time spent":"551.921019ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T18:19:50.120984Z","caller":"traceutil/trace.go:171","msg":"trace[2106529507] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"211.547719ms","start":"2026-06-22T18:19:49.9094Z","end":"2026-06-22T18:19:50.120948Z","steps":["trace[2106529507] 'process raft request' (duration: 211.206099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:52.511177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.406984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18bb7a275f8985ca\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-06-22T18:19:52.511292Z","caller":"traceutil/trace.go:171","msg":"trace[1883192483] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18bb7a275f8985ca; range_end:; response_count:1; response_revision:4840; }","duration":"316.576439ms","start":"2026-06-22T18:19:52.194687Z","end":"2026-06-22T18:19:52.511263Z","steps":["trace[1883192483] 'range keys from in-memory index tree' (duration: 316.216229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:52.511348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:52.194669Z","time spent":"316.666232ms","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":1035,"request content":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18bb7a275f8985ca\" "} {"level":"info","ts":"2026-06-22T18:19:52.52234Z","caller":"traceutil/trace.go:171","msg":"trace[15627291] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"281.454594ms","start":"2026-06-22T18:19:52.240861Z","end":"2026-06-22T18:19:52.522315Z","steps":["trace[15627291] 'process raft request' (duration: 281.230107ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:52.522711Z","caller":"traceutil/trace.go:171","msg":"trace[1665712185] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"135.249062ms","start":"2026-06-22T18:19:52.387449Z","end":"2026-06-22T18:19:52.522698Z","steps":["trace[1665712185] 'process raft request' (duration: 134.815899ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:58.347969Z","caller":"traceutil/trace.go:171","msg":"trace[680759903] linearizableReadLoop","detail":"{readStateIndex:5118; appliedIndex:5117; }","duration":"181.782546ms","start":"2026-06-22T18:19:58.166161Z","end":"2026-06-22T18:19:58.347943Z","steps":["trace[680759903] 'read index received' (duration: 176.490341ms)","trace[680759903] 'applied index is now lower than readState.Index' (duration: 5.291045ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:19:58.348238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.063876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:19:58.348286Z","caller":"traceutil/trace.go:171","msg":"trace[1425478271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4928; }","duration":"182.146438ms","start":"2026-06-22T18:19:58.166129Z","end":"2026-06-22T18:19:58.348275Z","steps":["trace[1425478271] 'agreement among raft nodes before linearized reading' (duration: 181.980163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:58.348431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.680131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-22T18:19:58.34845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.089591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T18:19:58.348502Z","caller":"traceutil/trace.go:171","msg":"trace[695860994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4928; }","duration":"179.804896ms","start":"2026-06-22T18:19:58.16868Z","end":"2026-06-22T18:19:58.348485Z","steps":["trace[695860994] 'agreement among raft nodes before linearized reading' (duration: 179.61609ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:58.348504Z","caller":"traceutil/trace.go:171","msg":"trace[68591841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4928; }","duration":"177.165273ms","start":"2026-06-22T18:19:58.171326Z","end":"2026-06-22T18:19:58.348492Z","steps":["trace[68591841] 'agreement among raft nodes before linearized reading' (duration: 177.027169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:58.348663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.495663ms","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-06-22T18:19:58.348696Z","caller":"traceutil/trace.go:171","msg":"trace[567375923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4928; }","duration":"177.560575ms","start":"2026-06-22T18:19:58.171128Z","end":"2026-06-22T18:19:58.348689Z","steps":["trace[567375923] 'agreement among raft nodes before linearized reading' (duration: 177.471542ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:58.348819Z","caller":"traceutil/trace.go:171","msg":"trace[680727564] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"199.415812ms","start":"2026-06-22T18:19:58.148686Z","end":"2026-06-22T18:19:58.348102Z","steps":["trace[680727564] 'process raft request' (duration: 194.058714ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:03.106256Z","caller":"traceutil/trace.go:171","msg":"trace[15164731] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"233.300083ms","start":"2026-06-22T18:20:02.872848Z","end":"2026-06-22T18:20:03.106148Z","steps":["trace[15164731] 'process raft request' (duration: 233.128888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:03.687979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.95876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:20:03.68806Z","caller":"traceutil/trace.go:171","msg":"trace[1546481202] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"740.577269ms","start":"2026-06-22T18:20:02.947467Z","end":"2026-06-22T18:20:03.688045Z","steps":["trace[1546481202] 'process raft request' (duration: 193.479445ms)","trace[1546481202] 'compare' (duration: 546.530917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:03.688102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:02.947438Z","time spent":"740.645481ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:20:03.708414Z","caller":"traceutil/trace.go:171","msg":"trace[2010073072] linearizableReadLoop","detail":"{readStateIndex:5164; appliedIndex:5163; }","duration":"428.739694ms","start":"2026-06-22T18:20:03.27965Z","end":"2026-06-22T18:20:03.708389Z","steps":["trace[2010073072] 'read index received' (duration: 428.537388ms)","trace[2010073072] 'applied index is now lower than readState.Index' (duration: 201.366µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:03.708455Z","caller":"traceutil/trace.go:171","msg":"trace[1420843595] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"578.440519ms","start":"2026-06-22T18:20:03.129983Z","end":"2026-06-22T18:20:03.708424Z","steps":["trace[1420843595] 'process raft request' (duration: 578.290295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:03.708734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.071844ms","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-06-22T18:20:03.708841Z","caller":"traceutil/trace.go:171","msg":"trace[1984690813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4973; }","duration":"429.24412ms","start":"2026-06-22T18:20:03.279584Z","end":"2026-06-22T18:20:03.708828Z","steps":["trace[1984690813] 'agreement among raft nodes before linearized reading' (duration: 428.989612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:03.708857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.571045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8\" ","response":"range_response_count:1 size:11844"} {"level":"info","ts":"2026-06-22T18:20:03.708939Z","caller":"traceutil/trace.go:171","msg":"trace[1460103032] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8; range_end:; response_count:1; response_revision:4973; }","duration":"336.700749ms","start":"2026-06-22T18:20:03.372218Z","end":"2026-06-22T18:20:03.708919Z","steps":["trace[1460103032] 'agreement among raft nodes before linearized reading' (duration: 336.41935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:03.708871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:03.129949Z","time spent":"578.710929ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:20:03.708947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:03.279564Z","time spent":"429.335433ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:20:03.708998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:03.372198Z","time spent":"336.782442ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11867,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-646d4df446-qsrp8\" "} {"level":"info","ts":"2026-06-22T18:20:03.824041Z","caller":"traceutil/trace.go:171","msg":"trace[895172245] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"102.222688ms","start":"2026-06-22T18:20:03.721781Z","end":"2026-06-22T18:20:03.824004Z","steps":["trace[895172245] 'process raft request' (duration: 77.360098ms)","trace[895172245] 'compare' (duration: 24.742767ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:34.830071Z","caller":"traceutil/trace.go:171","msg":"trace[255511776] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5379; }","duration":"237.680232ms","start":"2026-06-22T18:20:34.592379Z","end":"2026-06-22T18:20:34.83006Z","steps":["trace[255511776] 'read index received' (duration: 237.567618ms)","trace[255511776] 'applied index is now lower than readState.Index' (duration: 112.004µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:34.83027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.137776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:20:34.830346Z","caller":"traceutil/trace.go:171","msg":"trace[666091076] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"287.079322ms","start":"2026-06-22T18:20:34.543258Z","end":"2026-06-22T18:20:34.830338Z","steps":["trace[666091076] 'process raft request' (duration: 286.72393ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:34.830347Z","caller":"traceutil/trace.go:171","msg":"trace[1899676952] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:5183; }","duration":"178.24804ms","start":"2026-06-22T18:20:34.652088Z","end":"2026-06-22T18:20:34.830336Z","steps":["trace[1899676952] 'agreement among raft nodes before linearized reading' (duration: 178.137146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.830438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.067055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-22T18:20:34.830454Z","caller":"traceutil/trace.go:171","msg":"trace[1205886717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5183; }","duration":"238.121677ms","start":"2026-06-22T18:20:34.592328Z","end":"2026-06-22T18:20:34.83045Z","steps":["trace[1205886717] 'agreement among raft nodes before linearized reading' (duration: 238.063515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.830446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.875221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-22T18:20:34.830514Z","caller":"traceutil/trace.go:171","msg":"trace[96307919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5183; }","duration":"128.979933ms","start":"2026-06-22T18:20:34.701518Z","end":"2026-06-22T18:20:34.830498Z","steps":["trace[96307919] 'agreement among raft nodes before linearized reading' (duration: 128.774556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.830565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.749825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-22T18:20:34.830586Z","caller":"traceutil/trace.go:171","msg":"trace[1222995955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5183; }","duration":"136.809908ms","start":"2026-06-22T18:20:34.693771Z","end":"2026-06-22T18:20:34.830581Z","steps":["trace[1222995955] 'agreement among raft nodes before linearized reading' (duration: 136.763827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.830658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.075268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-22T18:20:34.830683Z","caller":"traceutil/trace.go:171","msg":"trace[877408299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5183; }","duration":"129.121969ms","start":"2026-06-22T18:20:34.701555Z","end":"2026-06-22T18:20:34.830677Z","steps":["trace[877408299] 'agreement among raft nodes before linearized reading' (duration: 129.057756ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:37.744818Z","caller":"traceutil/trace.go:171","msg":"trace[386543219] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"201.528423ms","start":"2026-06-22T18:20:37.54327Z","end":"2026-06-22T18:20:37.744799Z","steps":["trace[386543219] 'process raft request' (duration: 201.394069ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:37.879474Z","caller":"traceutil/trace.go:171","msg":"trace[774745558] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"336.117639ms","start":"2026-06-22T18:20:37.54332Z","end":"2026-06-22T18:20:37.879437Z","steps":["trace[774745558] 'process raft request' (duration: 313.902964ms)","trace[774745558] 'compare' (duration: 21.929996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:37.879633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:37.543296Z","time spent":"336.260184ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:20:53.193898Z","caller":"traceutil/trace.go:171","msg":"trace[1278236946] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"307.233776ms","start":"2026-06-22T18:20:52.886622Z","end":"2026-06-22T18:20:53.193856Z","steps":["trace[1278236946] 'process raft request' (duration: 307.002657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.194096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:52.88657Z","time spent":"307.424243ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:20:53.224445Z","caller":"traceutil/trace.go:171","msg":"trace[293843178] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5605; }","duration":"212.880333ms","start":"2026-06-22T18:20:53.011537Z","end":"2026-06-22T18:20:53.224417Z","steps":["trace[293843178] 'read index received' (duration: 182.162591ms)","trace[293843178] 'applied index is now lower than readState.Index' (duration: 30.716392ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:53.224574Z","caller":"traceutil/trace.go:171","msg":"trace[17265214] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"223.899776ms","start":"2026-06-22T18:20:53.000636Z","end":"2026-06-22T18:20:53.224536Z","steps":["trace[17265214] 'process raft request' (duration: 223.618726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.224663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.62553ms","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-06-22T18:20:53.224713Z","caller":"traceutil/trace.go:171","msg":"trace[950802580] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5404; }","duration":"195.724404ms","start":"2026-06-22T18:20:53.028977Z","end":"2026-06-22T18:20:53.224701Z","steps":["trace[950802580] 'agreement among raft nodes before linearized reading' (duration: 195.596559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.224816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.716147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-22T18:20:53.224817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.730276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T18:20:53.224888Z","caller":"traceutil/trace.go:171","msg":"trace[131515248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5404; }","duration":"144.83383ms","start":"2026-06-22T18:20:53.080036Z","end":"2026-06-22T18:20:53.22487Z","steps":["trace[131515248] 'agreement among raft nodes before linearized reading' (duration: 144.641534ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:53.224898Z","caller":"traceutil/trace.go:171","msg":"trace[29287040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5404; }","duration":"144.860552ms","start":"2026-06-22T18:20:53.08002Z","end":"2026-06-22T18:20:53.224881Z","steps":["trace[29287040] 'agreement among raft nodes before linearized reading' (duration: 144.655615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.224959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.692162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-22T18:20:53.225106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.557596ms","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-06-22T18:20:53.225128Z","caller":"traceutil/trace.go:171","msg":"trace[771164783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5404; }","duration":"137.92937ms","start":"2026-06-22T18:20:53.087148Z","end":"2026-06-22T18:20:53.225077Z","steps":["trace[771164783] 'agreement among raft nodes before linearized reading' (duration: 137.504006ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:53.225173Z","caller":"traceutil/trace.go:171","msg":"trace[922104860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5404; }","duration":"213.66912ms","start":"2026-06-22T18:20:53.011484Z","end":"2026-06-22T18:20:53.225153Z","steps":["trace[922104860] 'agreement among raft nodes before linearized reading' (duration: 213.042957ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:21:13.090309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2895} {"level":"info","ts":"2026-06-22T18:21:13.172758Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2895,"took":"79.517436ms","hash":4068713961,"current-db-size-bytes":53186560,"current-db-size":"53 MB","current-db-size-in-use-bytes":28864512,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-22T18:21:13.172836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4068713961,"revision":2895,"compact-revision":-1} {"level":"info","ts":"2026-06-22T18:21:32.416406Z","caller":"traceutil/trace.go:171","msg":"trace[922934750] linearizableReadLoop","detail":"{readStateIndex:5906; appliedIndex:5905; }","duration":"114.732694ms","start":"2026-06-22T18:21:32.301648Z","end":"2026-06-22T18:21:32.416381Z","steps":["trace[922934750] 'read index received' (duration: 114.518946ms)","trace[922934750] 'applied index is now lower than readState.Index' (duration: 212.498µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:21:32.416924Z","caller":"traceutil/trace.go:171","msg":"trace[87637109] transaction","detail":"{read_only:false; response_revision:5695; number_of_response:1; }","duration":"115.839245ms","start":"2026-06-22T18:21:32.301064Z","end":"2026-06-22T18:21:32.416903Z","steps":["trace[87637109] 'process raft request' (duration: 115.135129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:21:32.417557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.885856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-22T18:21:32.417773Z","caller":"traceutil/trace.go:171","msg":"trace[1784964704] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5695; }","duration":"116.119374ms","start":"2026-06-22T18:21:32.301639Z","end":"2026-06-22T18:21:32.417759Z","steps":["trace[1784964704] 'agreement among raft nodes before linearized reading' (duration: 115.204311ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:21:32.427097Z","caller":"traceutil/trace.go:171","msg":"trace[2113846692] transaction","detail":"{read_only:false; response_revision:5696; number_of_response:1; }","duration":"109.718241ms","start":"2026-06-22T18:21:32.317358Z","end":"2026-06-22T18:21:32.427077Z","steps":["trace[2113846692] 'process raft request' (duration: 109.500094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:23:34.152837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.798438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T18:23:34.153043Z","caller":"traceutil/trace.go:171","msg":"trace[351593414] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:6531; }","duration":"104.072838ms","start":"2026-06-22T18:23:34.048948Z","end":"2026-06-22T18:23:34.15302Z","steps":["trace[351593414] 'count revisions from in-memory index tree' (duration: 103.686753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:23:34.535781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.150162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-22T18:23:34.535871Z","caller":"traceutil/trace.go:171","msg":"trace[882185431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6533; }","duration":"182.308778ms","start":"2026-06-22T18:23:34.353539Z","end":"2026-06-22T18:23:34.535848Z","steps":["trace[882185431] 'range keys from in-memory index tree' (duration: 181.966932ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:23:34.536062Z","caller":"traceutil/trace.go:171","msg":"trace[1033646893] transaction","detail":"{read_only:false; response_revision:6535; number_of_response:1; }","duration":"108.489983ms","start":"2026-06-22T18:23:34.427549Z","end":"2026-06-22T18:23:34.536039Z","steps":["trace[1033646893] 'process raft request' (duration: 108.41078ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:23:34.536285Z","caller":"traceutil/trace.go:171","msg":"trace[639913720] transaction","detail":"{read_only:false; response_revision:6534; number_of_response:1; }","duration":"180.787548ms","start":"2026-06-22T18:23:34.355484Z","end":"2026-06-22T18:23:34.536272Z","steps":["trace[639913720] 'process raft request' (duration: 177.566831ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:23:44.740043Z","caller":"traceutil/trace.go:171","msg":"trace[1788522083] transaction","detail":"{read_only:false; response_revision:6591; number_of_response:1; }","duration":"150.42829ms","start":"2026-06-22T18:23:44.589591Z","end":"2026-06-22T18:23:44.740019Z","steps":["trace[1788522083] 'process raft request' (duration: 91.722424ms)","trace[1788522083] 'compare' (duration: 58.374323ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:24:07.406296Z","caller":"traceutil/trace.go:171","msg":"trace[1434462716] transaction","detail":"{read_only:false; response_revision:6761; number_of_response:1; }","duration":"142.790057ms","start":"2026-06-22T18:24:07.263481Z","end":"2026-06-22T18:24:07.406271Z","steps":["trace[1434462716] 'process raft request' (duration: 142.661352ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:24:54.471633Z","caller":"traceutil/trace.go:171","msg":"trace[1156105723] linearizableReadLoop","detail":"{readStateIndex:7283; appliedIndex:7282; }","duration":"145.220806ms","start":"2026-06-22T18:24:54.326393Z","end":"2026-06-22T18:24:54.471614Z","steps":["trace[1156105723] 'read index received' (duration: 145.026567ms)","trace[1156105723] 'applied index is now lower than readState.Index' (duration: 193.669µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:24:54.471817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.352561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:24:54.471848Z","caller":"traceutil/trace.go:171","msg":"trace[1503398199] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:7022; }","duration":"145.480827ms","start":"2026-06-22T18:24:54.326361Z","end":"2026-06-22T18:24:54.471842Z","steps":["trace[1503398199] 'agreement among raft nodes before linearized reading' (duration: 145.334091ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:24:54.47214Z","caller":"traceutil/trace.go:171","msg":"trace[1215590541] transaction","detail":"{read_only:false; response_revision:7022; number_of_response:1; }","duration":"326.595791ms","start":"2026-06-22T18:24:54.145509Z","end":"2026-06-22T18:24:54.472105Z","steps":["trace[1215590541] 'process raft request' (duration: 325.957195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:24:54.472299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:24:54.145494Z","time spent":"326.722115ms","remote":"127.0.0.1:51248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:26:13.096795Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5544} {"level":"info","ts":"2026-06-22T18:26:13.214328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5544,"took":"115.249099ms","hash":76491814,"current-db-size-bytes":53186560,"current-db-size":"53 MB","current-db-size-in-use-bytes":18620416,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-22T18:26:13.21438Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":76491814,"revision":5544,"compact-revision":2895}