{"level":"warn","ts":"2026-06-20T14:02:26.839862Z","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-20T14:02:26.839948Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-20T14:02:26.840013Z","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-20T14:02:26.840022Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-20T14:02:26.840041Z","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-20T14:02:26.84065Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-06-20T14:02:26.840732Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-20T14:02:26.869997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"29.026765ms"} {"level":"info","ts":"2026-06-20T14:02:26.960876Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-06-20T14:02:26.961025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-20T14:02:26.961071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-06-20T14:02:26.961097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-20T14:02:26.961124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-06-20T14:02:26.961186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-06-20T14:02:26.984835Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-20T14:02:26.987782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-20T14:02:26.995973Z","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-20T14:02:27.012349Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-20T14:02:27.015262Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-20T14:02:27.016889Z","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-20T14:02:27.017031Z","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-20T14:02:27.017088Z","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-20T14:02:27.017634Z","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-20T14:02:27.017818Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-20T14:02:27.017843Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-20T14:02:27.017908Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-20T14:02:27.017921Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-20T14:02:27.020924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-06-20T14:02:27.021009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-20T14:02:27.663141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-20T14:02:27.663196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-20T14:02:27.663239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-06-20T14:02:27.663257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-06-20T14:02:27.663272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-20T14:02:27.663297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-06-20T14:02:27.663322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-20T14:02:27.664459Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-20T14:02:27.664492Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T14:02:27.664765Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T14:02:27.664762Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T14:02:27.665684Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T14:02:27.665737Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T14:02:27.665756Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T14:02:27.666079Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-20T14:02:27.666108Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-20T14:02:27.6678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-06-20T14:02:27.670907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-20T14:02:34.240894Z","caller":"traceutil/trace.go:171","msg":"trace[1860890818] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"397.427511ms","start":"2026-06-20T14:02:33.843438Z","end":"2026-06-20T14:02:34.240865Z","steps":["trace[1860890818] 'process raft request' (duration: 397.275655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:34.241561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:33.843419Z","time spent":"397.64224ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:02:34.754407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435825359,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T14:02:35.255975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435825359,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T14:02:35.756968Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435825359,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T14:02:35.787317Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.533590233s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T14:02:35.795825Z","caller":"traceutil/trace.go:171","msg":"trace[1318344705] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"1.542098445s","start":"2026-06-20T14:02:34.253705Z","end":"2026-06-20T14:02:35.795804Z","steps":["trace[1318344705] 'read index received' (duration: 1.533819672s)","trace[1318344705] 'applied index is now lower than readState.Index' (duration: 8.277943ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:02:35.795918Z","caller":"traceutil/trace.go:171","msg":"trace[1894445778] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"1.542259962s","start":"2026-06-20T14:02:34.253639Z","end":"2026-06-20T14:02:35.795899Z","steps":["trace[1894445778] 'process raft request' (duration: 1.533910156s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:35.796013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.542292133s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-20T14:02:35.796086Z","caller":"traceutil/trace.go:171","msg":"trace[977300260] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:319; }","duration":"1.542397617s","start":"2026-06-20T14:02:34.253677Z","end":"2026-06-20T14:02:35.796075Z","steps":["trace[977300260] 'agreement among raft nodes before linearized reading' (duration: 1.542271282s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:35.79611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:34.253662Z","time spent":"1.54244197s","remote":"127.0.0.1:53834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-20T14:02:35.796202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:34.253626Z","time spent":"1.542353906s","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:02:35.796263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360356106s","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-20T14:02:35.796331Z","caller":"traceutil/trace.go:171","msg":"trace[59205966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:319; }","duration":"1.360478151s","start":"2026-06-20T14:02:34.435835Z","end":"2026-06-20T14:02:35.796313Z","steps":["trace[59205966] 'agreement among raft nodes before linearized reading' (duration: 1.360365307s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:35.796361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:34.435808Z","time spent":"1.360547064s","remote":"127.0.0.1:54010","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-20T14:02:35.796392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.11124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-20T14:02:35.796396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.330196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-20T14:02:35.796416Z","caller":"traceutil/trace.go:171","msg":"trace[813683822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:319; }","duration":"493.181723ms","start":"2026-06-20T14:02:35.303226Z","end":"2026-06-20T14:02:35.796408Z","steps":["trace[813683822] 'agreement among raft nodes before linearized reading' (duration: 493.138791ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:35.796419Z","caller":"traceutil/trace.go:171","msg":"trace[590277850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:319; }","duration":"649.383608ms","start":"2026-06-20T14:02:35.147029Z","end":"2026-06-20T14:02:35.796412Z","steps":["trace[590277850] 'agreement among raft nodes before linearized reading' (duration: 649.343857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:35.796433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.303199Z","time spent":"493.230675ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T14:02:35.796437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.147002Z","time spent":"649.43072ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T14:02:36.56043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.578866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T14:02:36.560655Z","caller":"traceutil/trace.go:171","msg":"trace[1644617985] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"759.852777ms","start":"2026-06-20T14:02:35.800787Z","end":"2026-06-20T14:02:36.56064Z","steps":["trace[1644617985] 'process raft request' (duration: 759.821106ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:36.560684Z","caller":"traceutil/trace.go:171","msg":"trace[2100121645] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"759.92659ms","start":"2026-06-20T14:02:35.800693Z","end":"2026-06-20T14:02:36.560619Z","steps":["trace[2100121645] 'process raft request' (duration: 464.948959ms)","trace[2100121645] 'compare' (duration: 294.466432ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:02:36.560728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.800783Z","time spent":"759.914049ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:02:36.560876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.800676Z","time spent":"760.099497ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:02:36.560852Z","caller":"traceutil/trace.go:171","msg":"trace[983821084] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"760.055495ms","start":"2026-06-20T14:02:35.80075Z","end":"2026-06-20T14:02:36.560773Z","steps":["trace[983821084] 'process raft request' (duration: 759.827947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:36.561067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.800741Z","time spent":"760.224741ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:02:36.560737Z","caller":"traceutil/trace.go:171","msg":"trace[1446708978] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"759.91954ms","start":"2026-06-20T14:02:35.800744Z","end":"2026-06-20T14:02:36.560663Z","steps":["trace[1446708978] 'process raft request' (duration: 759.784035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:36.561723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:02:35.800725Z","time spent":"760.950109ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":180,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:02:51.326262Z","caller":"traceutil/trace.go:171","msg":"trace[935014389] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"231.630995ms","start":"2026-06-20T14:02:51.094594Z","end":"2026-06-20T14:02:51.326225Z","steps":["trace[935014389] 'process raft request' (duration: 231.390662ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:51.326298Z","caller":"traceutil/trace.go:171","msg":"trace[908493867] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"229.288546ms","start":"2026-06-20T14:02:51.096984Z","end":"2026-06-20T14:02:51.326273Z","steps":["trace[908493867] 'process raft request' (duration: 229.134524ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:51.326494Z","caller":"traceutil/trace.go:171","msg":"trace[1443845046] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"229.409968ms","start":"2026-06-20T14:02:51.097075Z","end":"2026-06-20T14:02:51.326485Z","steps":["trace[1443845046] 'process raft request' (duration: 229.103884ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:51.326605Z","caller":"traceutil/trace.go:171","msg":"trace[766705671] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"229.308617ms","start":"2026-06-20T14:02:51.097276Z","end":"2026-06-20T14:02:51.326585Z","steps":["trace[766705671] 'process raft request' (duration: 228.944522ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:02:51.443017Z","caller":"traceutil/trace.go:171","msg":"trace[47762467] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:463; }","duration":"108.333187ms","start":"2026-06-20T14:02:51.334662Z","end":"2026-06-20T14:02:51.442996Z","steps":["trace[47762467] 'read index received' (duration: 16.614219ms)","trace[47762467] 'applied index is now lower than readState.Index' (duration: 91.717948ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:02:51.443195Z","caller":"traceutil/trace.go:171","msg":"trace[453284363] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"111.83821ms","start":"2026-06-20T14:02:51.331341Z","end":"2026-06-20T14:02:51.443179Z","steps":["trace[453284363] 'process raft request' (duration: 91.087681ms)","trace[453284363] 'compare' (duration: 20.271823ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:02:51.44329Z","caller":"traceutil/trace.go:171","msg":"trace[1196078995] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"108.895275ms","start":"2026-06-20T14:02:51.334373Z","end":"2026-06-20T14:02:51.443269Z","steps":["trace[1196078995] 'process raft request' (duration: 108.51102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:02:51.443768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.081016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-20T14:02:51.444314Z","caller":"traceutil/trace.go:171","msg":"trace[1342095542] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:449; }","duration":"109.684024ms","start":"2026-06-20T14:02:51.334615Z","end":"2026-06-20T14:02:51.444299Z","steps":["trace[1342095542] 'agreement among raft nodes before linearized reading' (duration: 108.469369ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:02.551683Z","caller":"traceutil/trace.go:171","msg":"trace[1189958566] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"215.913396ms","start":"2026-06-20T14:03:02.335709Z","end":"2026-06-20T14:03:02.551623Z","steps":["trace[1189958566] 'read index received' (duration: 215.723913ms)","trace[1189958566] 'applied index is now lower than readState.Index' (duration: 188.363µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:02.551713Z","caller":"traceutil/trace.go:171","msg":"trace[1275276726] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"614.903545ms","start":"2026-06-20T14:03:01.936777Z","end":"2026-06-20T14:03:02.551681Z","steps":["trace[1275276726] 'process raft request' (duration: 614.712532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:02.551873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:01.936761Z","time spent":"615.021056ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:02.551895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.15873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:02.551999Z","caller":"traceutil/trace.go:171","msg":"trace[1785563391] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:490; }","duration":"216.297622ms","start":"2026-06-20T14:03:02.335683Z","end":"2026-06-20T14:03:02.551981Z","steps":["trace[1785563391] 'agreement among raft nodes before linearized reading' (duration: 216.109039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.05774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.223916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:03.057834Z","caller":"traceutil/trace.go:171","msg":"trace[538856052] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:490; }","duration":"427.352339ms","start":"2026-06-20T14:03:02.630448Z","end":"2026-06-20T14:03:03.0578Z","steps":["trace[538856052] 'range keys from in-memory index tree' (duration: 427.162595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.057886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:02.630431Z","time spent":"427.44208ms","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T14:03:03.057946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.811339ms","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-20T14:03:03.057979Z","caller":"traceutil/trace.go:171","msg":"trace[2026886733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:490; }","duration":"299.883751ms","start":"2026-06-20T14:03:02.758087Z","end":"2026-06-20T14:03:03.057971Z","steps":["trace[2026886733] 'range keys from in-memory index tree' (duration: 299.725018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.058091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.127547ms","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-20T14:03:03.058114Z","caller":"traceutil/trace.go:171","msg":"trace[1321434293] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:490; }","duration":"320.173218ms","start":"2026-06-20T14:03:02.737935Z","end":"2026-06-20T14:03:03.058108Z","steps":["trace[1321434293] 'range keys from in-memory index tree' (duration: 320.041806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.058132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:02.737924Z","time spent":"320.203489ms","remote":"127.0.0.1:54010","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-20T14:03:03.058116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.094718ms","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:5"} {"level":"warn","ts":"2026-06-20T14:03:03.05834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.953185ms","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-20T14:03:03.05841Z","caller":"traceutil/trace.go:171","msg":"trace[1453072541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"299.053676ms","start":"2026-06-20T14:03:02.759339Z","end":"2026-06-20T14:03:03.058393Z","steps":["trace[1453072541] 'range keys from in-memory index tree' (duration: 298.821453ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:03.058343Z","caller":"traceutil/trace.go:171","msg":"trace[1358579071] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:490; }","duration":"400.359313ms","start":"2026-06-20T14:03:02.657952Z","end":"2026-06-20T14:03:03.058311Z","steps":["trace[1358579071] 'range keys from in-memory index tree' (duration: 399.996697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.058499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:02.657941Z","time spent":"400.542546ms","remote":"127.0.0.1:53802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-20T14:03:03.794433Z","caller":"traceutil/trace.go:171","msg":"trace[1290095060] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"731.612474ms","start":"2026-06-20T14:03:03.062786Z","end":"2026-06-20T14:03:03.794399Z","steps":["trace[1290095060] 'process raft request' (duration: 731.259318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:03.794666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.062754Z","time spent":"731.838508ms","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:05.407715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.379229ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T14:03:05.408466Z","caller":"traceutil/trace.go:171","msg":"trace[1069061429] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"2.345178861s","start":"2026-06-20T14:03:03.063194Z","end":"2026-06-20T14:03:05.408373Z","steps":["trace[1069061429] 'process raft request' (duration: 1.570990639s)","trace[1069061429] 'compare' (duration: 773.214976ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:05.40857Z","caller":"traceutil/trace.go:171","msg":"trace[1408818082] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"2.34512976s","start":"2026-06-20T14:03:03.063408Z","end":"2026-06-20T14:03:05.408538Z","steps":["trace[1408818082] 'process raft request' (duration: 2.344416078s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:05.408629Z","caller":"traceutil/trace.go:171","msg":"trace[1465480668] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.587859003s","start":"2026-06-20T14:03:03.820749Z","end":"2026-06-20T14:03:05.408608Z","steps":["trace[1465480668] 'process raft request' (duration: 1.587799472s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:05.408756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.063376Z","time spent":"2.345274083s","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:05.408802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.820714Z","time spent":"1.588024146s","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:05.408901Z","caller":"traceutil/trace.go:171","msg":"trace[1749771382] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:508; }","duration":"1.777885617s","start":"2026-06-20T14:03:03.630909Z","end":"2026-06-20T14:03:05.408795Z","steps":["trace[1749771382] 'read index received' (duration: 162.859146ms)","trace[1749771382] 'applied index is now lower than readState.Index' (duration: 1.615025511s)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:05.409017Z","caller":"traceutil/trace.go:171","msg":"trace[27871961] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.993449081s","start":"2026-06-20T14:03:03.415558Z","end":"2026-06-20T14:03:05.409007Z","steps":["trace[27871961] 'process raft request' (duration: 1.992916582s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:05.40857Z","caller":"traceutil/trace.go:171","msg":"trace[1252841972] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"2.345024808s","start":"2026-06-20T14:03:03.063514Z","end":"2026-06-20T14:03:05.408539Z","steps":["trace[1252841972] 'process raft request' (duration: 2.344922217s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:05.409092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.415535Z","time spent":"1.993513822s","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:05.409094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.063493Z","time spent":"2.345563328s","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:05.409215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.905758ms","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-20T14:03:05.409257Z","caller":"traceutil/trace.go:171","msg":"trace[1883565718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:497; }","duration":"852.971778ms","start":"2026-06-20T14:03:04.556272Z","end":"2026-06-20T14:03:05.409243Z","steps":["trace[1883565718] 'agreement among raft nodes before linearized reading' (duration: 852.904747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:05.409326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:04.556246Z","time spent":"853.071761ms","remote":"127.0.0.1:54010","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-20T14:03:05.409321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.778343834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:05.409433Z","caller":"traceutil/trace.go:171","msg":"trace[1576050286] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.588969742s","start":"2026-06-20T14:03:03.820454Z","end":"2026-06-20T14:03:05.409423Z","steps":["trace[1576050286] 'process raft request' (duration: 1.588060666s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:05.409447Z","caller":"traceutil/trace.go:171","msg":"trace[702391597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"1.778552358s","start":"2026-06-20T14:03:03.63086Z","end":"2026-06-20T14:03:05.409412Z","steps":["trace[702391597] 'agreement among raft nodes before linearized reading' (duration: 1.778313814s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:05.409485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.820424Z","time spent":"1.589038853s","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:05.409512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.630839Z","time spent":"1.77865867s","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T14:03:05.409699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:03.063164Z","time spent":"2.345402695s","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:07.915212Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435825797,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T14:03:08.354195Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.258953107s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T14:03:08.354595Z","caller":"traceutil/trace.go:171","msg":"trace[1381623079] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.259419756s","start":"2026-06-20T14:03:07.095149Z","end":"2026-06-20T14:03:08.354569Z","steps":["trace[1381623079] 'process raft request' (duration: 1.259274993s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.354791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.095128Z","time spent":"1.259557418s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.362768Z","caller":"traceutil/trace.go:171","msg":"trace[1831279228] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.254784366s","start":"2026-06-20T14:03:07.107897Z","end":"2026-06-20T14:03:08.362682Z","steps":["trace[1831279228] 'process raft request' (duration: 1.254640933s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:08.362948Z","caller":"traceutil/trace.go:171","msg":"trace[1899040964] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.251970355s","start":"2026-06-20T14:03:07.110964Z","end":"2026-06-20T14:03:08.362934Z","steps":["trace[1899040964] 'process raft request' (duration: 1.251750611s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:08.363098Z","caller":"traceutil/trace.go:171","msg":"trace[1088975142] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.239081366s","start":"2026-06-20T14:03:07.123997Z","end":"2026-06-20T14:03:08.363079Z","steps":["trace[1088975142] 'process raft request' (duration: 1.238912663s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.110956Z","time spent":"1.252073877s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.362821Z","caller":"traceutil/trace.go:171","msg":"trace[357170269] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.253275288s","start":"2026-06-20T14:03:07.109502Z","end":"2026-06-20T14:03:08.362778Z","steps":["trace[357170269] 'process raft request' (duration: 1.253098225s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.123977Z","time spent":"1.239179197s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.362821Z","caller":"traceutil/trace.go:171","msg":"trace[1954804720] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.258727776s","start":"2026-06-20T14:03:07.103898Z","end":"2026-06-20T14:03:08.362626Z","steps":["trace[1954804720] 'process raft request' (duration: 1.258509522s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:08.362837Z","caller":"traceutil/trace.go:171","msg":"trace[1895568390] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.253102806s","start":"2026-06-20T14:03:07.109702Z","end":"2026-06-20T14:03:08.362804Z","steps":["trace[1895568390] 'process raft request' (duration: 1.252962783s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.109481Z","time spent":"1.253782668s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:08.363385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.109695Z","time spent":"1.253666676s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.362978Z","caller":"traceutil/trace.go:171","msg":"trace[1575328816] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.244641705s","start":"2026-06-20T14:03:07.118324Z","end":"2026-06-20T14:03:08.362966Z","steps":["trace[1575328816] 'process raft request' (duration: 1.244528313s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:08.363413Z","caller":"traceutil/trace.go:171","msg":"trace[704453989] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:549; }","duration":"948.919947ms","start":"2026-06-20T14:03:07.414468Z","end":"2026-06-20T14:03:08.363388Z","steps":["trace[704453989] 'read index received' (duration: 940.737569ms)","trace[704453989] 'applied index is now lower than readState.Index' (duration: 8.180998ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:08.363468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.118304Z","time spent":"1.245143614s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.363508Z","caller":"traceutil/trace.go:171","msg":"trace[2029083508] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.235607424s","start":"2026-06-20T14:03:07.127884Z","end":"2026-06-20T14:03:08.363492Z","steps":["trace[2029083508] 'process raft request' (duration: 1.235090055s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.107882Z","time spent":"1.255089421s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:08.363598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.127878Z","time spent":"1.235667755s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.363727Z","caller":"traceutil/trace.go:171","msg":"trace[704907063] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.210634169s","start":"2026-06-20T14:03:07.153082Z","end":"2026-06-20T14:03:08.363716Z","steps":["trace[704907063] 'process raft request' (duration: 1.209960087s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:08.363742Z","caller":"traceutil/trace.go:171","msg":"trace[1578214623] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.207136757s","start":"2026-06-20T14:03:07.156578Z","end":"2026-06-20T14:03:08.363714Z","steps":["trace[1578214623] 'process raft request' (duration: 1.206616938s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.103881Z","time spent":"1.259480699s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:08.363794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.153057Z","time spent":"1.21070896s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:08.363808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.156561Z","time spent":"1.207205608s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:08.363825Z","caller":"traceutil/trace.go:171","msg":"trace[188373200] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.097315231s","start":"2026-06-20T14:03:07.266493Z","end":"2026-06-20T14:03:08.363808Z","steps":["trace[188373200] 'process raft request' (duration: 1.096793432s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.363911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.266451Z","time spent":"1.097422452s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:08.364003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.528928ms","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-20T14:03:08.364033Z","caller":"traceutil/trace.go:171","msg":"trace[1966578564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:541; }","duration":"949.62162ms","start":"2026-06-20T14:03:07.414404Z","end":"2026-06-20T14:03:08.364026Z","steps":["trace[1966578564] 'agreement among raft nodes before linearized reading' (duration: 949.467077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.36408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.414383Z","time spent":"949.691021ms","remote":"127.0.0.1:54010","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-20T14:03:08.369369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.808573ms","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-20T14:03:08.369409Z","caller":"traceutil/trace.go:171","msg":"trace[1916731059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:542; }","duration":"950.857913ms","start":"2026-06-20T14:03:07.418542Z","end":"2026-06-20T14:03:08.3694Z","steps":["trace[1916731059] 'agreement among raft nodes before linearized reading' (duration: 950.756622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.369377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.992679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-20T14:03:08.369444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.635253ms","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-20T14:03:08.369463Z","caller":"traceutil/trace.go:171","msg":"trace[589397292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:542; }","duration":"954.155462ms","start":"2026-06-20T14:03:07.415289Z","end":"2026-06-20T14:03:08.369444Z","steps":["trace[589397292] 'agreement among raft nodes before linearized reading' (duration: 953.990649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.369518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.415243Z","time spent":"954.265844ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T14:03:08.369434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.418512Z","time spent":"950.916635ms","remote":"127.0.0.1:54010","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-20T14:03:08.369484Z","caller":"traceutil/trace.go:171","msg":"trace[1908915251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:542; }","duration":"953.691824ms","start":"2026-06-20T14:03:07.415783Z","end":"2026-06-20T14:03:08.369475Z","steps":["trace[1908915251] 'agreement among raft nodes before linearized reading' (duration: 953.576012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.369808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.415775Z","time spent":"954.016609ms","remote":"127.0.0.1:54010","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-20T14:03:08.369422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.931034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:08.370131Z","caller":"traceutil/trace.go:171","msg":"trace[100528127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"737.685777ms","start":"2026-06-20T14:03:07.632432Z","end":"2026-06-20T14:03:08.370118Z","steps":["trace[100528127] 'agreement among raft nodes before linearized reading' (duration: 736.903173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:08.370175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:07.632421Z","time spent":"737.743279ms","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-20T14:03:14.647721Z","caller":"traceutil/trace.go:171","msg":"trace[1851593231] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"205.537229ms","start":"2026-06-20T14:03:14.442149Z","end":"2026-06-20T14:03:14.647687Z","steps":["trace[1851593231] 'process raft request' (duration: 205.337535ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:14.973405Z","caller":"traceutil/trace.go:171","msg":"trace[311932306] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"528.745382ms","start":"2026-06-20T14:03:14.444645Z","end":"2026-06-20T14:03:14.973391Z","steps":["trace[311932306] 'process raft request' (duration: 528.578549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.974311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.444632Z","time spent":"529.540288ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:14.974623Z","caller":"traceutil/trace.go:171","msg":"trace[807805571] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"527.605009ms","start":"2026-06-20T14:03:14.446951Z","end":"2026-06-20T14:03:14.974556Z","steps":["trace[807805571] 'process raft request' (duration: 526.320484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.974874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.446927Z","time spent":"527.827113ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:14.974373Z","caller":"traceutil/trace.go:171","msg":"trace[609495246] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"529.63858ms","start":"2026-06-20T14:03:14.443698Z","end":"2026-06-20T14:03:14.973336Z","steps":["trace[609495246] 'process raft request' (duration: 529.261373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.97781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.443682Z","time spent":"531.478326ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:14.982553Z","caller":"traceutil/trace.go:171","msg":"trace[1382050091] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:661; }","duration":"359.414916ms","start":"2026-06-20T14:03:14.623093Z","end":"2026-06-20T14:03:14.982508Z","steps":["trace[1382050091] 'read index received' (duration: 24.475868ms)","trace[1382050091] 'applied index is now lower than readState.Index' (duration: 334.938248ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:14.982696Z","caller":"traceutil/trace.go:171","msg":"trace[442600805] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"503.867035ms","start":"2026-06-20T14:03:14.47881Z","end":"2026-06-20T14:03:14.982677Z","steps":["trace[442600805] 'process raft request' (duration: 499.351565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.982764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.872395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T14:03:14.982801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.711631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kwgmz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-20T14:03:14.982837Z","caller":"traceutil/trace.go:171","msg":"trace[1568435629] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kwgmz; range_end:; response_count:1; response_revision:642; }","duration":"359.778483ms","start":"2026-06-20T14:03:14.623045Z","end":"2026-06-20T14:03:14.982823Z","steps":["trace[1568435629] 'agreement among raft nodes before linearized reading' (duration: 359.62156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.982866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.623025Z","time spent":"359.837164ms","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-kwgmz\" "} {"level":"warn","ts":"2026-06-20T14:03:14.982926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.478772Z","time spent":"504.006338ms","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:14.982817Z","caller":"traceutil/trace.go:171","msg":"trace[581816307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"350.988828ms","start":"2026-06-20T14:03:14.631818Z","end":"2026-06-20T14:03:14.982807Z","steps":["trace[581816307] 'agreement among raft nodes before linearized reading' (duration: 350.865445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:14.983024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.6318Z","time spent":"351.216032ms","remote":"127.0.0.1:53724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T14:03:16.110512Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.114882256s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T14:03:16.111064Z","caller":"traceutil/trace.go:171","msg":"trace[917470901] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.11559701s","start":"2026-06-20T14:03:14.995442Z","end":"2026-06-20T14:03:16.111039Z","steps":["trace[917470901] 'process raft request' (duration: 1.115447887s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:16.111206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:14.995408Z","time spent":"1.115724653s","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:16.162638Z","caller":"traceutil/trace.go:171","msg":"trace[2100585811] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.122599418s","start":"2026-06-20T14:03:15.039978Z","end":"2026-06-20T14:03:16.162577Z","steps":["trace[2100585811] 'process raft request' (duration: 1.122280482s)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:16.162709Z","caller":"traceutil/trace.go:171","msg":"trace[1100901664] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"714.521306ms","start":"2026-06-20T14:03:15.448166Z","end":"2026-06-20T14:03:16.162688Z","steps":["trace[1100901664] 'process raft request' (duration: 714.278481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:16.162789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:15.039952Z","time spent":"1.122763682s","remote":"127.0.0.1:53986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:16.162822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:15.448138Z","time spent":"714.628348ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:16.950222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.65192ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-20T14:03:16.950326Z","caller":"traceutil/trace.go:171","msg":"trace[1020819952] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:666; }","duration":"1.318629355s","start":"2026-06-20T14:03:15.631678Z","end":"2026-06-20T14:03:16.950307Z","steps":["trace[1020819952] 'read index received' (duration: 479.208453ms)","trace[1020819952] 'applied index is now lower than readState.Index' (duration: 839.419512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:16.950448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.318795678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:16.950483Z","caller":"traceutil/trace.go:171","msg":"trace[1839602620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.318869009s","start":"2026-06-20T14:03:15.631604Z","end":"2026-06-20T14:03:16.950473Z","steps":["trace[1839602620] 'agreement among raft nodes before linearized reading' (duration: 1.318803628s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:16.950519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:15.631589Z","time spent":"1.318923141s","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T14:03:16.950542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.602407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-20T14:03:16.950608Z","caller":"traceutil/trace.go:171","msg":"trace[1857872476] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:645; }","duration":"783.7156ms","start":"2026-06-20T14:03:16.16688Z","end":"2026-06-20T14:03:16.950596Z","steps":["trace[1857872476] 'agreement among raft nodes before linearized reading' (duration: 783.603257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:16.95064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.166861Z","time spent":"783.772531ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-20T14:03:16.95066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.640723ms","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-20T14:03:16.950728Z","caller":"traceutil/trace.go:171","msg":"trace[992300856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"298.717795ms","start":"2026-06-20T14:03:16.651992Z","end":"2026-06-20T14:03:16.95071Z","steps":["trace[992300856] 'agreement among raft nodes before linearized reading' (duration: 298.513571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.460224Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435825995,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-20T14:03:17.631597Z","caller":"traceutil/trace.go:171","msg":"trace[421325280] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"675.469254ms","start":"2026-06-20T14:03:16.956087Z","end":"2026-06-20T14:03:17.631557Z","steps":["trace[421325280] 'process raft request' (duration: 675.117726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.631719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.723656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:17.631785Z","caller":"traceutil/trace.go:171","msg":"trace[2001903291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"671.828429ms","start":"2026-06-20T14:03:16.959937Z","end":"2026-06-20T14:03:17.631766Z","steps":["trace[2001903291] 'agreement among raft nodes before linearized reading' (duration: 671.694526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.631814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.956075Z","time spent":"675.641767ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:17.63185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.959925Z","time spent":"671.911861ms","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-20T14:03:17.631532Z","caller":"traceutil/trace.go:171","msg":"trace[1623190917] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"671.541643ms","start":"2026-06-20T14:03:16.959967Z","end":"2026-06-20T14:03:17.631508Z","steps":["trace[1623190917] 'read index received' (duration: 671.128854ms)","trace[1623190917] 'applied index is now lower than readState.Index' (duration: 411.849µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:17.632303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.39693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:17.632367Z","caller":"traceutil/trace.go:171","msg":"trace[1453273669] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:646; }","duration":"670.483541ms","start":"2026-06-20T14:03:16.961863Z","end":"2026-06-20T14:03:17.632347Z","steps":["trace[1453273669] 'agreement among raft nodes before linearized reading' (duration: 670.398779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.632413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.961849Z","time spent":"670.550063ms","remote":"127.0.0.1:53872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-20T14:03:17.632396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.626514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-20T14:03:17.632412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.335137ms","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-20T14:03:17.632462Z","caller":"traceutil/trace.go:171","msg":"trace[598921844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"648.715185ms","start":"2026-06-20T14:03:16.983728Z","end":"2026-06-20T14:03:17.632443Z","steps":["trace[598921844] 'agreement among raft nodes before linearized reading' (duration: 648.541722ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:17.632467Z","caller":"traceutil/trace.go:171","msg":"trace[842112026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"647.414958ms","start":"2026-06-20T14:03:16.985038Z","end":"2026-06-20T14:03:17.632453Z","steps":["trace[842112026] 'agreement among raft nodes before linearized reading' (duration: 647.241005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.632515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.983717Z","time spent":"648.789957ms","remote":"127.0.0.1:54010","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-20T14:03:17.63252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.985023Z","time spent":"647.485281ms","remote":"127.0.0.1:54010","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-20T14:03:17.63283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.592464ms","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-20T14:03:17.633044Z","caller":"traceutil/trace.go:171","msg":"trace[1981574890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"650.963262ms","start":"2026-06-20T14:03:16.982044Z","end":"2026-06-20T14:03:17.633007Z","steps":["trace[1981574890] 'agreement among raft nodes before linearized reading' (duration: 650.558103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:17.633173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:16.982027Z","time spent":"651.084734ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T14:03:20.143037Z","caller":"traceutil/trace.go:171","msg":"trace[1148813322] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"408.138569ms","start":"2026-06-20T14:03:19.734874Z","end":"2026-06-20T14:03:20.143013Z","steps":["trace[1148813322] 'process raft request' (duration: 407.993776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:20.143201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:19.734858Z","time spent":"408.249391ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:20.148653Z","caller":"traceutil/trace.go:171","msg":"trace[793981324] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"293.424454ms","start":"2026-06-20T14:03:19.855183Z","end":"2026-06-20T14:03:20.148607Z","steps":["trace[793981324] 'process raft request' (duration: 293.075086ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:20.148814Z","caller":"traceutil/trace.go:171","msg":"trace[1926722035] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"291.452802ms","start":"2026-06-20T14:03:19.857352Z","end":"2026-06-20T14:03:20.148804Z","steps":["trace[1926722035] 'process raft request' (duration: 290.946851ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:20.148868Z","caller":"traceutil/trace.go:171","msg":"trace[235553441] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"205.280925ms","start":"2026-06-20T14:03:19.943568Z","end":"2026-06-20T14:03:20.148849Z","steps":["trace[235553441] 'process raft request' (duration: 204.765124ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:20.149063Z","caller":"traceutil/trace.go:171","msg":"trace[814407965] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"410.106262ms","start":"2026-06-20T14:03:19.738948Z","end":"2026-06-20T14:03:20.149054Z","steps":["trace[814407965] 'process raft request' (duration: 409.131881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:20.149165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:19.738932Z","time spent":"410.157923ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:20.149245Z","caller":"traceutil/trace.go:171","msg":"trace[1393168798] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"410.200254ms","start":"2026-06-20T14:03:19.739036Z","end":"2026-06-20T14:03:20.149237Z","steps":["trace[1393168798] 'process raft request' (duration: 409.160952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:20.14929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:19.739011Z","time spent":"410.253695ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:23.116619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.649424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-20T14:03:23.116815Z","caller":"traceutil/trace.go:171","msg":"trace[1865513763] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"445.436931ms","start":"2026-06-20T14:03:22.671353Z","end":"2026-06-20T14:03:23.11679Z","steps":["trace[1865513763] 'process raft request' (duration: 186.514321ms)","trace[1865513763] 'compare' (duration: 258.48996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:23.117024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:22.671338Z","time spent":"445.584445ms","remote":"127.0.0.1:53788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:23.146625Z","caller":"traceutil/trace.go:171","msg":"trace[25120784] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"388.439649ms","start":"2026-06-20T14:03:22.758165Z","end":"2026-06-20T14:03:23.146605Z","steps":["trace[25120784] 'process raft request' (duration: 388.178374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.146738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:22.75814Z","time spent":"388.534822ms","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18322,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:23.146831Z","caller":"traceutil/trace.go:171","msg":"trace[1087490631] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:743; }","duration":"293.205755ms","start":"2026-06-20T14:03:22.853553Z","end":"2026-06-20T14:03:23.146759Z","steps":["trace[1087490631] 'read index received' (duration: 4.327685ms)","trace[1087490631] 'applied index is now lower than readState.Index' (duration: 288.87705ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:23.146854Z","caller":"traceutil/trace.go:171","msg":"trace[1598698940] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"384.811539ms","start":"2026-06-20T14:03:22.762016Z","end":"2026-06-20T14:03:23.146827Z","steps":["trace[1598698940] 'process raft request' (duration: 384.544103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.147077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:22.761998Z","time spent":"384.978174ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:23.147112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.562313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-20T14:03:23.147163Z","caller":"traceutil/trace.go:171","msg":"trace[970441295] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:720; }","duration":"293.650944ms","start":"2026-06-20T14:03:22.853497Z","end":"2026-06-20T14:03:23.147148Z","steps":["trace[970441295] 'agreement among raft nodes before linearized reading' (duration: 293.412169ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:23.440947Z","caller":"traceutil/trace.go:171","msg":"trace[693007184] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"360.966208ms","start":"2026-06-20T14:03:23.079879Z","end":"2026-06-20T14:03:23.440845Z","steps":["trace[693007184] 'process raft request' (duration: 272.381198ms)","trace[693007184] 'compare' (duration: 88.336244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:23.441078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:23.07985Z","time spent":"361.171193ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:23.500304Z","caller":"traceutil/trace.go:171","msg":"trace[1294406633] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:746; }","duration":"246.449698ms","start":"2026-06-20T14:03:23.253833Z","end":"2026-06-20T14:03:23.500282Z","steps":["trace[1294406633] 'read index received' (duration: 98.43842ms)","trace[1294406633] 'applied index is now lower than readState.Index' (duration: 148.010348ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:23.500466Z","caller":"traceutil/trace.go:171","msg":"trace[1480721257] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"337.632396ms","start":"2026-06-20T14:03:23.162805Z","end":"2026-06-20T14:03:23.500437Z","steps":["trace[1480721257] 'process raft request' (duration: 337.316549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.500655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:23.162788Z","time spent":"337.763349ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:23.500679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.827576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-20T14:03:23.500725Z","caller":"traceutil/trace.go:171","msg":"trace[1896005416] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:722; }","duration":"246.924668ms","start":"2026-06-20T14:03:23.253788Z","end":"2026-06-20T14:03:23.500713Z","steps":["trace[1896005416] 'agreement among raft nodes before linearized reading' (duration: 246.593761ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:23.810757Z","caller":"traceutil/trace.go:171","msg":"trace[2041951025] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"310.347516ms","start":"2026-06-20T14:03:23.500375Z","end":"2026-06-20T14:03:23.810722Z","steps":["trace[2041951025] 'read index received' (duration: 310.096311ms)","trace[2041951025] 'applied index is now lower than readState.Index' (duration: 250.035µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:23.810864Z","caller":"traceutil/trace.go:171","msg":"trace[898906654] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"321.481495ms","start":"2026-06-20T14:03:23.489374Z","end":"2026-06-20T14:03:23.810856Z","steps":["trace[898906654] 'process raft request' (duration: 320.988384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.811296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.114105ms","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-20T14:03:23.811382Z","caller":"traceutil/trace.go:171","msg":"trace[949161052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"346.209607ms","start":"2026-06-20T14:03:23.465151Z","end":"2026-06-20T14:03:23.811361Z","steps":["trace[949161052] 'agreement among raft nodes before linearized reading' (duration: 345.916401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.81143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:23.465098Z","time spent":"346.322931ms","remote":"127.0.0.1:54010","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-20T14:03:23.810968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:23.489359Z","time spent":"321.536676ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T14:03:23.878014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.251974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-06-20T14:03:23.878097Z","caller":"traceutil/trace.go:171","msg":"trace[264835279] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:724; }","duration":"225.371267ms","start":"2026-06-20T14:03:23.652706Z","end":"2026-06-20T14:03:23.878077Z","steps":["trace[264835279] 'agreement among raft nodes before linearized reading' (duration: 225.162303ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:23.878187Z","caller":"traceutil/trace.go:171","msg":"trace[391949791] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"368.011015ms","start":"2026-06-20T14:03:23.51014Z","end":"2026-06-20T14:03:23.878151Z","steps":["trace[391949791] 'process raft request' (duration: 367.375301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:23.878368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:23.510118Z","time spent":"368.155518ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:23.87842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.094775ms","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-20T14:03:23.878459Z","caller":"traceutil/trace.go:171","msg":"trace[1911152584] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"214.178207ms","start":"2026-06-20T14:03:23.664269Z","end":"2026-06-20T14:03:23.878448Z","steps":["trace[1911152584] 'agreement among raft nodes before linearized reading' (duration: 214.057754ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.124524Z","caller":"traceutil/trace.go:171","msg":"trace[767492844] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:753; }","duration":"160.732522ms","start":"2026-06-20T14:03:23.963756Z","end":"2026-06-20T14:03:24.124489Z","steps":["trace[767492844] 'read index received' (duration: 160.723082ms)","trace[767492844] 'applied index is now lower than readState.Index' (duration: 7.84µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:24.124529Z","caller":"traceutil/trace.go:171","msg":"trace[194054915] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"164.587578ms","start":"2026-06-20T14:03:23.959908Z","end":"2026-06-20T14:03:24.124495Z","steps":["trace[194054915] 'process raft request' (duration: 164.390424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:24.124823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.040579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188243"} {"level":"info","ts":"2026-06-20T14:03:24.124901Z","caller":"traceutil/trace.go:171","msg":"trace[1702060723] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:727; }","duration":"161.170932ms","start":"2026-06-20T14:03:23.963713Z","end":"2026-06-20T14:03:24.124884Z","steps":["trace[1702060723] 'agreement among raft nodes before linearized reading' (duration: 160.901146ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.168814Z","caller":"traceutil/trace.go:171","msg":"trace[610526762] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"196.297949ms","start":"2026-06-20T14:03:23.972491Z","end":"2026-06-20T14:03:24.168789Z","steps":["trace[610526762] 'process raft request' (duration: 196.056563ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.169125Z","caller":"traceutil/trace.go:171","msg":"trace[1926428809] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"167.386982ms","start":"2026-06-20T14:03:24.001727Z","end":"2026-06-20T14:03:24.169114Z","steps":["trace[1926428809] 'process raft request' (duration: 167.014903ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.383516Z","caller":"traceutil/trace.go:171","msg":"trace[2078981086] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"210.065697ms","start":"2026-06-20T14:03:24.173422Z","end":"2026-06-20T14:03:24.383488Z","steps":["trace[2078981086] 'process raft request' (duration: 203.55921ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.384082Z","caller":"traceutil/trace.go:171","msg":"trace[1007582788] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"210.365454ms","start":"2026-06-20T14:03:24.173681Z","end":"2026-06-20T14:03:24.384047Z","steps":["trace[1007582788] 'process raft request' (duration: 209.734509ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.38437Z","caller":"traceutil/trace.go:171","msg":"trace[1899911203] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"209.413912ms","start":"2026-06-20T14:03:24.174813Z","end":"2026-06-20T14:03:24.384227Z","steps":["trace[1899911203] 'process raft request' (duration: 209.202507ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:24.386805Z","caller":"traceutil/trace.go:171","msg":"trace[1871468840] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"150.372278ms","start":"2026-06-20T14:03:24.236395Z","end":"2026-06-20T14:03:24.386768Z","steps":["trace[1871468840] 'process raft request' (duration: 150.062601ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.12865Z","caller":"traceutil/trace.go:171","msg":"trace[564506115] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"220.237234ms","start":"2026-06-20T14:03:29.90839Z","end":"2026-06-20T14:03:30.128628Z","steps":["trace[564506115] 'read index received' (duration: 220.010019ms)","trace[564506115] 'applied index is now lower than readState.Index' (duration: 226.245µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:30.128699Z","caller":"traceutil/trace.go:171","msg":"trace[1039560454] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"313.40411ms","start":"2026-06-20T14:03:29.815257Z","end":"2026-06-20T14:03:30.128661Z","steps":["trace[1039560454] 'process raft request' (duration: 313.239706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.12884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:29.815231Z","time spent":"313.539173ms","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18698,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:30.128856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.51635ms","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-20T14:03:30.128895Z","caller":"traceutil/trace.go:171","msg":"trace[1886802661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"217.583851ms","start":"2026-06-20T14:03:29.911302Z","end":"2026-06-20T14:03:30.128886Z","steps":["trace[1886802661] 'agreement among raft nodes before linearized reading' (duration: 217.471529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.128858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.45107ms","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-20T14:03:30.128987Z","caller":"traceutil/trace.go:171","msg":"trace[244638452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:761; }","duration":"220.625624ms","start":"2026-06-20T14:03:29.908349Z","end":"2026-06-20T14:03:30.128975Z","steps":["trace[244638452] 'agreement among raft nodes before linearized reading' (duration: 220.372777ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.370189Z","caller":"traceutil/trace.go:171","msg":"trace[423746033] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"145.234696ms","start":"2026-06-20T14:03:30.224891Z","end":"2026-06-20T14:03:30.370125Z","steps":["trace[423746033] 'process raft request' (duration: 87.339286ms)","trace[423746033] 'compare' (duration: 57.702055ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:30.395938Z","caller":"traceutil/trace.go:171","msg":"trace[2049242935] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"164.340855ms","start":"2026-06-20T14:03:30.231581Z","end":"2026-06-20T14:03:30.395922Z","steps":["trace[2049242935] 'process raft request' (duration: 164.271603ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.396137Z","caller":"traceutil/trace.go:171","msg":"trace[702083406] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"164.439386ms","start":"2026-06-20T14:03:30.231548Z","end":"2026-06-20T14:03:30.395987Z","steps":["trace[702083406] 'process raft request' (duration: 164.211131ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.901462Z","caller":"traceutil/trace.go:171","msg":"trace[495984750] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"486.879056ms","start":"2026-06-20T14:03:30.414557Z","end":"2026-06-20T14:03:30.901436Z","steps":["trace[495984750] 'process raft request' (duration: 486.682001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.901813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.414543Z","time spent":"487.037279ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:30.938659Z","caller":"traceutil/trace.go:171","msg":"trace[648309515] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"471.070097ms","start":"2026-06-20T14:03:30.467534Z","end":"2026-06-20T14:03:30.938604Z","steps":["trace[648309515] 'process raft request' (duration: 470.867402ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.938722Z","caller":"traceutil/trace.go:171","msg":"trace[948205404] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"468.423163ms","start":"2026-06-20T14:03:30.470268Z","end":"2026-06-20T14:03:30.938691Z","steps":["trace[948205404] 'process raft request' (duration: 468.236678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.938874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.470254Z","time spent":"468.536725ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T14:03:30.938885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.467515Z","time spent":"471.23294ms","remote":"127.0.0.1:53788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T14:03:30.939166Z","caller":"traceutil/trace.go:171","msg":"trace[296822816] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"464.437637ms","start":"2026-06-20T14:03:30.47471Z","end":"2026-06-20T14:03:30.939148Z","steps":["trace[296822816] 'process raft request' (duration: 463.854303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.939386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.474696Z","time spent":"464.529279ms","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4726,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:30.938644Z","caller":"traceutil/trace.go:171","msg":"trace[1890742769] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:800; }","duration":"365.38807ms","start":"2026-06-20T14:03:30.573235Z","end":"2026-06-20T14:03:30.938623Z","steps":["trace[1890742769] 'read index received' (duration: 328.020853ms)","trace[1890742769] 'applied index is now lower than readState.Index' (duration: 37.366037ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:30.939598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.354133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-06-20T14:03:30.939696Z","caller":"traceutil/trace.go:171","msg":"trace[917637160] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:775; }","duration":"366.498277ms","start":"2026-06-20T14:03:30.573184Z","end":"2026-06-20T14:03:30.939682Z","steps":["trace[917637160] 'agreement among raft nodes before linearized reading' (duration: 366.300872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.939732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.57316Z","time spent":"366.562138ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":203,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "} {"level":"warn","ts":"2026-06-20T14:03:30.939939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.910614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T14:03:30.939945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.21246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:30.939991Z","caller":"traceutil/trace.go:171","msg":"trace[905084572] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:775; }","duration":"279.011337ms","start":"2026-06-20T14:03:30.660968Z","end":"2026-06-20T14:03:30.939979Z","steps":["trace[905084572] 'agreement among raft nodes before linearized reading' (duration: 278.927255ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:30.939996Z","caller":"traceutil/trace.go:171","msg":"trace[1393143753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"306.299362ms","start":"2026-06-20T14:03:30.633684Z","end":"2026-06-20T14:03:30.939984Z","steps":["trace[1393143753] 'agreement among raft nodes before linearized reading' (duration: 306.22137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.939993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.114881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-20T14:03:30.940079Z","caller":"traceutil/trace.go:171","msg":"trace[81145726] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:775; }","duration":"262.238834ms","start":"2026-06-20T14:03:30.67782Z","end":"2026-06-20T14:03:30.940059Z","steps":["trace[81145726] 'agreement among raft nodes before linearized reading' (duration: 261.987408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.940147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.63366Z","time spent":"306.362643ms","remote":"127.0.0.1:53712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T14:03:30.94029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.165869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"info","ts":"2026-06-20T14:03:30.940335Z","caller":"traceutil/trace.go:171","msg":"trace[1555338533] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:775; }","duration":"366.899206ms","start":"2026-06-20T14:03:30.573424Z","end":"2026-06-20T14:03:30.940323Z","steps":["trace[1555338533] 'agreement among raft nodes before linearized reading' (duration: 366.089797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:30.940367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:30.573401Z","time spent":"366.957798ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":857,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-20T14:03:36.605916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533201435826326,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T14:03:36.989765Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.205441346s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T14:03:36.990243Z","caller":"traceutil/trace.go:171","msg":"trace[62769860] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"1.246116817s","start":"2026-06-20T14:03:35.744078Z","end":"2026-06-20T14:03:36.990195Z","steps":["trace[62769860] 'process raft request' (duration: 1.245938703s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:36.990397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:35.744056Z","time spent":"1.24625136s","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:37.130898Z","caller":"traceutil/trace.go:171","msg":"trace[166555074] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:843; }","duration":"1.025054487s","start":"2026-06-20T14:03:36.105819Z","end":"2026-06-20T14:03:37.130874Z","steps":["trace[166555074] 'read index received' (duration: 884.16916ms)","trace[166555074] 'applied index is now lower than readState.Index' (duration: 140.884367ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:37.13108Z","caller":"traceutil/trace.go:171","msg":"trace[440513321] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"838.81704ms","start":"2026-06-20T14:03:36.292247Z","end":"2026-06-20T14:03:37.131064Z","steps":["trace[440513321] 'process raft request' (duration: 838.520562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.497183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-20T14:03:37.131348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.598697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-20T14:03:37.131373Z","caller":"traceutil/trace.go:171","msg":"trace[602809261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"736.621677ms","start":"2026-06-20T14:03:36.394729Z","end":"2026-06-20T14:03:37.131351Z","steps":["trace[602809261] 'agreement among raft nodes before linearized reading' (duration: 736.385391ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:37.131408Z","caller":"traceutil/trace.go:171","msg":"trace[905067185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"920.687589ms","start":"2026-06-20T14:03:36.210702Z","end":"2026-06-20T14:03:37.13139Z","steps":["trace[905067185] 'agreement among raft nodes before linearized reading' (duration: 920.35001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.1311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025266353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-20T14:03:37.131386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.073935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-20T14:03:37.13153Z","caller":"traceutil/trace.go:171","msg":"trace[548706490] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:815; }","duration":"1.025761955s","start":"2026-06-20T14:03:36.105756Z","end":"2026-06-20T14:03:37.131518Z","steps":["trace[548706490] 'agreement among raft nodes before linearized reading' (duration: 1.025247452s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.09034ms","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-20T14:03:37.131474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.394701Z","time spent":"736.75528ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T14:03:37.131663Z","caller":"traceutil/trace.go:171","msg":"trace[1496628526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"169.542411ms","start":"2026-06-20T14:03:36.962089Z","end":"2026-06-20T14:03:37.131632Z","steps":["trace[1496628526] 'agreement among raft nodes before linearized reading' (duration: 169.054189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.692492ms","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":"info","ts":"2026-06-20T14:03:37.131853Z","caller":"traceutil/trace.go:171","msg":"trace[2074539083] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:815; }","duration":"643.431001ms","start":"2026-06-20T14:03:36.488403Z","end":"2026-06-20T14:03:37.131834Z","steps":["trace[2074539083] 'agreement among raft nodes before linearized reading' (duration: 642.689862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.105731Z","time spent":"1.025851357s","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":96,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-20T14:03:37.131736Z","caller":"traceutil/trace.go:171","msg":"trace[286356467] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"890.342902ms","start":"2026-06-20T14:03:36.241214Z","end":"2026-06-20T14:03:37.131557Z","steps":["trace[286356467] 'agreement among raft nodes before linearized reading' (duration: 889.934692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.488382Z","time spent":"643.519363ms","remote":"127.0.0.1:53946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-06-20T14:03:37.131264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.515162ms","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-20T14:03:37.131985Z","caller":"traceutil/trace.go:171","msg":"trace[130766702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"208.23628ms","start":"2026-06-20T14:03:36.923737Z","end":"2026-06-20T14:03:37.131973Z","steps":["trace[130766702] 'agreement among raft nodes before linearized reading' (duration: 207.425769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:37.131479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.21068Z","time spent":"920.786361ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T14:03:37.131985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.241194Z","time spent":"890.774863ms","remote":"127.0.0.1:54010","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-20T14:03:37.132105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:36.292229Z","time spent":"839.092087ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:51.299234Z","caller":"traceutil/trace.go:171","msg":"trace[1692476065] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"419.04784ms","start":"2026-06-20T14:03:50.880161Z","end":"2026-06-20T14:03:51.299208Z","steps":["trace[1692476065] 'process raft request' (duration: 418.850824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.299678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T14:03:50.880139Z","time spent":"419.426451ms","remote":"127.0.0.1:54184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T14:03:51.307557Z","caller":"traceutil/trace.go:171","msg":"trace[348756057] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1009; }","duration":"147.341445ms","start":"2026-06-20T14:03:51.160189Z","end":"2026-06-20T14:03:51.30753Z","steps":["trace[348756057] 'read index received' (duration: 138.852287ms)","trace[348756057] 'applied index is now lower than readState.Index' (duration: 8.488168ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:03:51.307797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.578251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:51.307862Z","caller":"traceutil/trace.go:171","msg":"trace[426035268] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:977; }","duration":"147.684695ms","start":"2026-06-20T14:03:51.160162Z","end":"2026-06-20T14:03:51.307847Z","steps":["trace[426035268] 'agreement among raft nodes before linearized reading' (duration: 147.548811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.307942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.86499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T14:03:51.30803Z","caller":"traceutil/trace.go:171","msg":"trace[147274280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"102.967052ms","start":"2026-06-20T14:03:51.205051Z","end":"2026-06-20T14:03:51.308019Z","steps":["trace[147274280] 'agreement among raft nodes before linearized reading' (duration: 102.714325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.307928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.802546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-cfqkx\" ","response":"range_response_count:1 size:5677"} {"level":"info","ts":"2026-06-20T14:03:51.308128Z","caller":"traceutil/trace.go:171","msg":"trace[1102638511] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-cfqkx; range_end:; response_count:1; response_revision:977; }","duration":"114.058213ms","start":"2026-06-20T14:03:51.194049Z","end":"2026-06-20T14:03:51.308107Z","steps":["trace[1102638511] 'agreement among raft nodes before linearized reading' (duration: 113.687783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.308134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.694539ms","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-20T14:03:51.308185Z","caller":"traceutil/trace.go:171","msg":"trace[888303367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:977; }","duration":"100.757431ms","start":"2026-06-20T14:03:51.207411Z","end":"2026-06-20T14:03:51.308168Z","steps":["trace[888303367] 'agreement among raft nodes before linearized reading' (duration: 100.584246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.308029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.855455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T14:03:51.308324Z","caller":"traceutil/trace.go:171","msg":"trace[928108072] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:977; }","duration":"105.157814ms","start":"2026-06-20T14:03:51.203149Z","end":"2026-06-20T14:03:51.308307Z","steps":["trace[928108072] 'agreement among raft nodes before linearized reading' (duration: 104.850155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.308684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.295228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-20T14:03:51.308718Z","caller":"traceutil/trace.go:171","msg":"trace[134426129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"110.340069ms","start":"2026-06-20T14:03:51.198368Z","end":"2026-06-20T14:03:51.308708Z","steps":["trace[134426129] 'agreement among raft nodes before linearized reading' (duration: 110.246866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:51.308927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.563845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-20T14:03:51.308963Z","caller":"traceutil/trace.go:171","msg":"trace[1161204441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:977; }","duration":"110.629827ms","start":"2026-06-20T14:03:51.198323Z","end":"2026-06-20T14:03:51.308953Z","steps":["trace[1161204441] 'agreement among raft nodes before linearized reading' (duration: 109.499155ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:51.307592Z","caller":"traceutil/trace.go:171","msg":"trace[1513510622] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"296.956893ms","start":"2026-06-20T14:03:51.010617Z","end":"2026-06-20T14:03:51.307574Z","steps":["trace[1513510622] 'process raft request' (duration: 296.806459ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:51.747466Z","caller":"traceutil/trace.go:171","msg":"trace[826335155] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"150.819652ms","start":"2026-06-20T14:03:51.596632Z","end":"2026-06-20T14:03:51.747451Z","steps":["trace[826335155] 'process raft request' (duration: 150.734109ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:51.930457Z","caller":"traceutil/trace.go:171","msg":"trace[1801862095] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"120.473783ms","start":"2026-06-20T14:03:51.809952Z","end":"2026-06-20T14:03:51.930426Z","steps":["trace[1801862095] 'process raft request' (duration: 120.333209ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:55.537236Z","caller":"traceutil/trace.go:171","msg":"trace[1650845217] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"131.935286ms","start":"2026-06-20T14:03:55.405279Z","end":"2026-06-20T14:03:55.537214Z","steps":["trace[1650845217] 'read index received' (duration: 131.833103ms)","trace[1650845217] 'applied index is now lower than readState.Index' (duration: 101.143µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:55.537344Z","caller":"traceutil/trace.go:171","msg":"trace[696947806] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"160.238365ms","start":"2026-06-20T14:03:55.377096Z","end":"2026-06-20T14:03:55.537335Z","steps":["trace[696947806] 'process raft request' (duration: 159.961887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:55.53756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.196463ms","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-20T14:03:55.537643Z","caller":"traceutil/trace.go:171","msg":"trace[444109510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1000; }","duration":"132.310816ms","start":"2026-06-20T14:03:55.405315Z","end":"2026-06-20T14:03:55.537626Z","steps":["trace[444109510] 'agreement among raft nodes before linearized reading' (duration: 132.060999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:55.537586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.648668ms","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-20T14:03:55.537668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.333187ms","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-20T14:03:55.537761Z","caller":"traceutil/trace.go:171","msg":"trace[916958051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1000; }","duration":"131.839933ms","start":"2026-06-20T14:03:55.4059Z","end":"2026-06-20T14:03:55.53774Z","steps":["trace[916958051] 'agreement among raft nodes before linearized reading' (duration: 131.586325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:55.538001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.566743ms","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-20T14:03:55.538074Z","caller":"traceutil/trace.go:171","msg":"trace[1302814607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"132.663027ms","start":"2026-06-20T14:03:55.405393Z","end":"2026-06-20T14:03:55.538056Z","steps":["trace[1302814607] 'agreement among raft nodes before linearized reading' (duration: 132.143652ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:55.538309Z","caller":"traceutil/trace.go:171","msg":"trace[2070682243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1000; }","duration":"132.548883ms","start":"2026-06-20T14:03:55.405239Z","end":"2026-06-20T14:03:55.537788Z","steps":["trace[2070682243] 'agreement among raft nodes before linearized reading' (duration: 132.264165ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:55.810568Z","caller":"traceutil/trace.go:171","msg":"trace[1923945373] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"268.487073ms","start":"2026-06-20T14:03:55.54206Z","end":"2026-06-20T14:03:55.810547Z","steps":["trace[1923945373] 'process raft request' (duration: 194.925798ms)","trace[1923945373] 'compare' (duration: 73.430791ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:55.810791Z","caller":"traceutil/trace.go:171","msg":"trace[465604538] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1035; }","duration":"179.492676ms","start":"2026-06-20T14:03:55.631282Z","end":"2026-06-20T14:03:55.810774Z","steps":["trace[465604538] 'read index received' (duration: 105.691825ms)","trace[465604538] 'applied index is now lower than readState.Index' (duration: 73.800281ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:03:55.810879Z","caller":"traceutil/trace.go:171","msg":"trace[691592406] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"268.573485ms","start":"2026-06-20T14:03:55.542298Z","end":"2026-06-20T14:03:55.810871Z","steps":["trace[691592406] 'process raft request' (duration: 268.217075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:03:55.810917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.61959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T14:03:55.810935Z","caller":"traceutil/trace.go:171","msg":"trace[114970215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1004; }","duration":"179.680962ms","start":"2026-06-20T14:03:55.631248Z","end":"2026-06-20T14:03:55.810929Z","steps":["trace[114970215] 'agreement among raft nodes before linearized reading' (duration: 179.591579ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:03:55.811679Z","caller":"traceutil/trace.go:171","msg":"trace[1358459628] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"266.891057ms","start":"2026-06-20T14:03:55.544122Z","end":"2026-06-20T14:03:55.811013Z","steps":["trace[1358459628] 'process raft request' (duration: 266.579788ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:04:24.206208Z","caller":"traceutil/trace.go:171","msg":"trace[964532232] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"133.100716ms","start":"2026-06-20T14:04:24.073083Z","end":"2026-06-20T14:04:24.206184Z","steps":["trace[964532232] 'process raft request' (duration: 119.512889ms)","trace[964532232] 'compare' (duration: 13.293977ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:04:24.20626Z","caller":"traceutil/trace.go:171","msg":"trace[952586501] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"131.250536ms","start":"2026-06-20T14:04:24.074971Z","end":"2026-06-20T14:04:24.206222Z","steps":["trace[952586501] 'process raft request' (duration: 131.121392ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:02.536048Z","caller":"traceutil/trace.go:171","msg":"trace[1660041590] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"130.055772ms","start":"2026-06-20T14:05:02.405958Z","end":"2026-06-20T14:05:02.536014Z","steps":["trace[1660041590] 'process raft request' (duration: 129.263545ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:02.536142Z","caller":"traceutil/trace.go:171","msg":"trace[1582899396] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"126.490718ms","start":"2026-06-20T14:05:02.409435Z","end":"2026-06-20T14:05:02.535926Z","steps":["trace[1582899396] 'read index received' (duration: 125.800744ms)","trace[1582899396] 'applied index is now lower than readState.Index' (duration: 689.284µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:05:02.536305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.847271ms","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-20T14:05:02.536374Z","caller":"traceutil/trace.go:171","msg":"trace[201502691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1227; }","duration":"126.945184ms","start":"2026-06-20T14:05:02.409412Z","end":"2026-06-20T14:05:02.536358Z","steps":["trace[201502691] 'agreement among raft nodes before linearized reading' (duration: 126.730357ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:19.90438Z","caller":"traceutil/trace.go:171","msg":"trace[1797900661] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1360; }","duration":"100.098257ms","start":"2026-06-20T14:05:19.804261Z","end":"2026-06-20T14:05:19.904359Z","steps":["trace[1797900661] 'read index received' (duration: 43.513711ms)","trace[1797900661] 'applied index is now lower than readState.Index' (duration: 56.583486ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:05:19.904457Z","caller":"traceutil/trace.go:171","msg":"trace[888448568] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"110.635251ms","start":"2026-06-20T14:05:19.793798Z","end":"2026-06-20T14:05:19.904434Z","steps":["trace[888448568] 'process raft request' (duration: 110.006019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T14:05:19.904604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.318815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-06-20T14:05:19.904693Z","caller":"traceutil/trace.go:171","msg":"trace[286168771] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1309; }","duration":"100.443059ms","start":"2026-06-20T14:05:19.804233Z","end":"2026-06-20T14:05:19.904676Z","steps":["trace[286168771] 'agreement among raft nodes before linearized reading' (duration: 100.240052ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:20.810145Z","caller":"traceutil/trace.go:171","msg":"trace[396065955] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"126.288265ms","start":"2026-06-20T14:05:20.683827Z","end":"2026-06-20T14:05:20.810115Z","steps":["trace[396065955] 'read index received' (duration: 71.960498ms)","trace[396065955] 'applied index is now lower than readState.Index' (duration: 54.326477ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:05:20.810312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.454841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-20T14:05:20.81041Z","caller":"traceutil/trace.go:171","msg":"trace[940886525] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:1317; }","duration":"126.568995ms","start":"2026-06-20T14:05:20.683824Z","end":"2026-06-20T14:05:20.810393Z","steps":["trace[940886525] 'agreement among raft nodes before linearized reading' (duration: 126.377569ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:20.810764Z","caller":"traceutil/trace.go:171","msg":"trace[1492817993] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"128.202604ms","start":"2026-06-20T14:05:20.681948Z","end":"2026-06-20T14:05:20.810151Z","steps":["trace[1492817993] 'process raft request' (duration: 73.890957ms)","trace[1492817993] 'compare' (duration: 54.064548ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T14:05:26.236183Z","caller":"traceutil/trace.go:171","msg":"trace[176346992] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1386; }","duration":"105.446766ms","start":"2026-06-20T14:05:26.130706Z","end":"2026-06-20T14:05:26.236153Z","steps":["trace[176346992] 'read index received' (duration: 54.092782ms)","trace[176346992] 'applied index is now lower than readState.Index' (duration: 51.352303ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T14:05:26.236475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.742366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T14:05:26.236564Z","caller":"traceutil/trace.go:171","msg":"trace[1706051349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1332; }","duration":"105.899442ms","start":"2026-06-20T14:05:26.130647Z","end":"2026-06-20T14:05:26.236547Z","steps":["trace[1706051349] 'agreement among raft nodes before linearized reading' (duration: 105.615431ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T14:05:34.888499Z","caller":"traceutil/trace.go:171","msg":"trace[795576835] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"110.390523ms","start":"2026-06-20T14:05:34.778085Z","end":"2026-06-20T14:05:34.888476Z","steps":["trace[795576835] 'process raft request' (duration: 75.129758ms)","trace[795576835] 'compare' (duration: 35.177762ms)"],"step_count":2}