{"level":"warn","ts":"2026-06-05T04:39:25.624656Z","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-05T04:39:25.624745Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-05T04:39:25.624807Z","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-05T04:39:25.624819Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-05T04:39:25.624838Z","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-05T04:39:25.625435Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-06-05T04:39:25.625507Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-05T04:39:25.630866Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.17593ms"} {"level":"info","ts":"2026-06-05T04:39:25.642015Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-06-05T04:39:25.642099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T04:39:25.642117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-06-05T04:39:25.642131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T04:39:25.642142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-06-05T04:39:25.642177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-06-05T04:39:25.650504Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T04:39:25.651789Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T04:39:25.657362Z","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-05T04:39:25.659867Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T04:39:25.660094Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T04:39:25.660115Z","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-05T04:39:25.660223Z","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-05T04:39:25.660237Z","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-05T04:39:25.66569Z","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-05T04:39:25.66594Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T04:39:25.665986Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T04:39:25.666024Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-05T04:39:25.666034Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-05T04:39:25.666118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-06-05T04:39:25.666346Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-05T04:39:26.642812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T04:39:26.64289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T04:39:26.642936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-06-05T04:39:26.642961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-06-05T04:39:26.64297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-05T04:39:26.642988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-06-05T04:39:26.643001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-05T04:39:26.644077Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T04:39:26.644119Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:39:26.644278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:39:26.644498Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:39:26.644616Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T04:39:26.6447Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T04:39:26.646471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-06-05T04:39:26.64684Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:39:26.646936Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:39:26.64697Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:39:26.647114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T04:39:29.577385Z","caller":"traceutil/trace.go:171","msg":"trace[1025522158] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"124.403757ms","start":"2026-06-05T04:39:29.452953Z","end":"2026-06-05T04:39:29.577357Z","steps":["trace[1025522158] 'process raft request' (duration: 122.240926ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:39:30.435123Z","caller":"traceutil/trace.go:171","msg":"trace[1588001407] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"113.098577ms","start":"2026-06-05T04:39:30.321969Z","end":"2026-06-05T04:39:30.435068Z","steps":["trace[1588001407] 'process raft request' (duration: 29.620158ms)","trace[1588001407] 'compare' (duration: 83.251955ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:39:30.663495Z","caller":"traceutil/trace.go:171","msg":"trace[1332200640] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"220.049383ms","start":"2026-06-05T04:39:30.443412Z","end":"2026-06-05T04:39:30.663461Z","steps":["trace[1332200640] 'process raft request' (duration: 124.012899ms)","trace[1332200640] 'compare' (duration: 95.906242ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:39:30.6892Z","caller":"traceutil/trace.go:171","msg":"trace[1756858538] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"231.274202ms","start":"2026-06-05T04:39:30.457907Z","end":"2026-06-05T04:39:30.689181Z","steps":["trace[1756858538] 'process raft request' (duration: 230.767373ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:39:35.767756Z","caller":"traceutil/trace.go:171","msg":"trace[1057194537] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"224.566832ms","start":"2026-06-05T04:39:35.543163Z","end":"2026-06-05T04:39:35.76773Z","steps":["trace[1057194537] 'process raft request' (duration: 224.424119ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:39:35.944715Z","caller":"traceutil/trace.go:171","msg":"trace[1738483584] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"167.262774ms","start":"2026-06-05T04:39:35.777423Z","end":"2026-06-05T04:39:35.944685Z","steps":["trace[1738483584] 'process raft request' (duration: 96.562784ms)","trace[1738483584] 'compare' (duration: 70.574288ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:39:42.388779Z","caller":"traceutil/trace.go:171","msg":"trace[797596254] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"612.891927ms","start":"2026-06-05T04:39:41.775863Z","end":"2026-06-05T04:39:42.388755Z","steps":["trace[797596254] 'process raft request' (duration: 612.752214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:42.389533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:41.775843Z","time spent":"613.027169ms","remote":"127.0.0.1:33634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:39:43.140308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.369396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:39:43.140421Z","caller":"traceutil/trace.go:171","msg":"trace[413308149] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"1.166199393s","start":"2026-06-05T04:39:41.974205Z","end":"2026-06-05T04:39:43.140404Z","steps":["trace[413308149] 'read index received' (duration: 414.313943ms)","trace[413308149] 'applied index is now lower than readState.Index' (duration: 751.88441ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:39:43.140684Z","caller":"traceutil/trace.go:171","msg":"trace[1521527629] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"1.315682498s","start":"2026-06-05T04:39:41.824987Z","end":"2026-06-05T04:39:43.14067Z","steps":["trace[1521527629] 'process raft request' (duration: 676.741222ms)","trace[1521527629] 'compare' (duration: 638.05732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:39:43.14075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:41.824964Z","time spent":"1.3157533s","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:39:43.140832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.18659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:39:43.140848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.892223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:39:43.140916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046414948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T04:39:43.140916Z","caller":"traceutil/trace.go:171","msg":"trace[537524118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"889.995466ms","start":"2026-06-05T04:39:42.250906Z","end":"2026-06-05T04:39:43.140901Z","steps":["trace[537524118] 'agreement among raft nodes before linearized reading' (duration: 889.878353ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:39:43.140926Z","caller":"traceutil/trace.go:171","msg":"trace[46785047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"110.311902ms","start":"2026-06-05T04:39:43.030581Z","end":"2026-06-05T04:39:43.140893Z","steps":["trace[46785047] 'agreement among raft nodes before linearized reading' (duration: 110.197139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:43.140959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:42.25089Z","time spent":"890.061637ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:39:43.140958Z","caller":"traceutil/trace.go:171","msg":"trace[1410556796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:409; }","duration":"1.046462659s","start":"2026-06-05T04:39:42.09448Z","end":"2026-06-05T04:39:43.140943Z","steps":["trace[1410556796] 'agreement among raft nodes before linearized reading' (duration: 1.046395817s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:43.14084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053249261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-05T04:39:43.140994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:42.094472Z","time spent":"1.046514359s","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:39:43.141007Z","caller":"traceutil/trace.go:171","msg":"trace[445385533] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"1.053478046s","start":"2026-06-05T04:39:42.087518Z","end":"2026-06-05T04:39:43.140996Z","steps":["trace[445385533] 'agreement among raft nodes before linearized reading' (duration: 1.05323699s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:43.141044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:42.087498Z","time spent":"1.053535336s","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:39:43.141013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166805496s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T04:39:43.141125Z","caller":"traceutil/trace.go:171","msg":"trace[114213732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"1.166977769s","start":"2026-06-05T04:39:41.974118Z","end":"2026-06-05T04:39:43.141095Z","steps":["trace[114213732] 'agreement among raft nodes before linearized reading' (duration: 1.166792096s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:43.141178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:41.974097Z","time spent":"1.167068551s","remote":"127.0.0.1:33718","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-05T04:39:43.871611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.404239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:39:43.871709Z","caller":"traceutil/trace.go:171","msg":"trace[278739976] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"726.001755ms","start":"2026-06-05T04:39:43.145693Z","end":"2026-06-05T04:39:43.871695Z","steps":["trace[278739976] 'process raft request' (duration: 403.432391ms)","trace[278739976] 'compare' (duration: 322.281967ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:39:43.871754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:43.145629Z","time spent":"726.104226ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:39:44.124644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.380112ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:39:44.125075Z","caller":"traceutil/trace.go:171","msg":"trace[1051995492] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"979.143152ms","start":"2026-06-05T04:39:43.145907Z","end":"2026-06-05T04:39:44.12505Z","steps":["trace[1051995492] 'process raft request' (duration: 979.085811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:44.125326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:43.145876Z","time spent":"979.380607ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:39:44.125408Z","caller":"traceutil/trace.go:171","msg":"trace[96116220] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"979.631262ms","start":"2026-06-05T04:39:43.145745Z","end":"2026-06-05T04:39:44.125376Z","steps":["trace[96116220] 'process raft request' (duration: 867.294291ms)","trace[96116220] 'compare' (duration: 111.182658ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:39:44.125696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:43.145728Z","time spent":"979.859646ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:39:44.125778Z","caller":"traceutil/trace.go:171","msg":"trace[1348917777] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"979.872656ms","start":"2026-06-05T04:39:43.145891Z","end":"2026-06-05T04:39:44.125764Z","steps":["trace[1348917777] 'process raft request' (duration: 979.028919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:39:44.125854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:39:43.145883Z","time spent":"979.929117ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:39:46.016575Z","caller":"traceutil/trace.go:171","msg":"trace[2017510785] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"136.412441ms","start":"2026-06-05T04:39:45.880132Z","end":"2026-06-05T04:39:46.016544Z","steps":["trace[2017510785] 'process raft request' (duration: 136.186167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.293712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.828687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:40:06.293831Z","caller":"traceutil/trace.go:171","msg":"trace[1020135436] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"253.780632ms","start":"2026-06-05T04:40:06.040033Z","end":"2026-06-05T04:40:06.293814Z","steps":["trace[1020135436] 'process raft request' (duration: 109.773261ms)","trace[1020135436] 'compare' (duration: 143.678074ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:06.295506Z","caller":"traceutil/trace.go:171","msg":"trace[1460328755] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"170.074079ms","start":"2026-06-05T04:40:06.125391Z","end":"2026-06-05T04:40:06.295465Z","steps":["trace[1460328755] 'read index received' (duration: 24.430356ms)","trace[1460328755] 'applied index is now lower than readState.Index' (duration: 145.642863ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:06.295626Z","caller":"traceutil/trace.go:171","msg":"trace[857768346] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"241.276768ms","start":"2026-06-05T04:40:06.054227Z","end":"2026-06-05T04:40:06.295503Z","steps":["trace[857768346] 'process raft request' (duration: 241.131826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.295738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.308213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T04:40:06.295778Z","caller":"traceutil/trace.go:171","msg":"trace[525965904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"170.418426ms","start":"2026-06-05T04:40:06.12535Z","end":"2026-06-05T04:40:06.295768Z","steps":["trace[525965904] 'agreement among raft nodes before linearized reading' (duration: 170.219223ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.523842Z","caller":"traceutil/trace.go:171","msg":"trace[1878211806] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"183.629052ms","start":"2026-06-05T04:40:06.340192Z","end":"2026-06-05T04:40:06.523821Z","steps":["trace[1878211806] 'process raft request' (duration: 183.554541ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.524131Z","caller":"traceutil/trace.go:171","msg":"trace[1744036313] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"221.398339ms","start":"2026-06-05T04:40:06.302712Z","end":"2026-06-05T04:40:06.524111Z","steps":["trace[1744036313] 'process raft request' (duration: 220.890349ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.524128Z","caller":"traceutil/trace.go:171","msg":"trace[1447636434] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"214.112297ms","start":"2026-06-05T04:40:06.30998Z","end":"2026-06-05T04:40:06.524093Z","steps":["trace[1447636434] 'process raft request' (duration: 213.687779ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.524341Z","caller":"traceutil/trace.go:171","msg":"trace[1453969735] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"228.778403ms","start":"2026-06-05T04:40:06.295545Z","end":"2026-06-05T04:40:06.524324Z","steps":["trace[1453969735] 'read index received' (duration: 164.826526ms)","trace[1453969735] 'applied index is now lower than readState.Index' (duration: 63.950467ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:06.524349Z","caller":"traceutil/trace.go:171","msg":"trace[470819453] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"364.629273ms","start":"2026-06-05T04:40:06.159678Z","end":"2026-06-05T04:40:06.524308Z","steps":["trace[470819453] 'process raft request' (duration: 300.676687ms)","trace[470819453] 'compare' (duration: 62.912787ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:06.524596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.548148ms","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-05T04:40:06.524648Z","caller":"traceutil/trace.go:171","msg":"trace[702310103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"229.65184ms","start":"2026-06-05T04:40:06.294982Z","end":"2026-06-05T04:40:06.524634Z","steps":["trace[702310103] 'agreement among raft nodes before linearized reading' (duration: 229.502637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.524673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.817032ms","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-05T04:40:06.52472Z","caller":"traceutil/trace.go:171","msg":"trace[1010534374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"234.928663ms","start":"2026-06-05T04:40:06.289781Z","end":"2026-06-05T04:40:06.524709Z","steps":["trace[1010534374] 'agreement among raft nodes before linearized reading' (duration: 234.75846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.524837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:06.159641Z","time spent":"364.90288ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:40:06.525055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.60248ms","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-05T04:40:06.525096Z","caller":"traceutil/trace.go:171","msg":"trace[1381727973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"248.687162ms","start":"2026-06-05T04:40:06.2764Z","end":"2026-06-05T04:40:06.525087Z","steps":["trace[1381727973] 'agreement among raft nodes before linearized reading' (duration: 247.978458ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.799619Z","caller":"traceutil/trace.go:171","msg":"trace[741156545] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"121.188875ms","start":"2026-06-05T04:40:06.678396Z","end":"2026-06-05T04:40:06.799584Z","steps":["trace[741156545] 'read index received' (duration: 109.281073ms)","trace[741156545] 'applied index is now lower than readState.Index' (duration: 11.906272ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:06.799709Z","caller":"traceutil/trace.go:171","msg":"trace[139709154] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"174.842861ms","start":"2026-06-05T04:40:06.624832Z","end":"2026-06-05T04:40:06.799675Z","steps":["trace[139709154] 'process raft request' (duration: 162.688694ms)","trace[139709154] 'compare' (duration: 11.868192ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:06.799856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.409519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.799994Z","caller":"traceutil/trace.go:171","msg":"trace[1418495858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:597; }","duration":"121.630403ms","start":"2026-06-05T04:40:06.678348Z","end":"2026-06-05T04:40:06.799978Z","steps":["trace[1418495858] 'agreement among raft nodes before linearized reading' (duration: 121.390969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.898412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.931541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.898483Z","caller":"traceutil/trace.go:171","msg":"trace[797644870] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:598; }","duration":"220.037635ms","start":"2026-06-05T04:40:06.678431Z","end":"2026-06-05T04:40:06.898468Z","steps":["trace[797644870] 'agreement among raft nodes before linearized reading' (duration: 219.900912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.898638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.437664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.898701Z","caller":"traceutil/trace.go:171","msg":"trace[876754525] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"130.519186ms","start":"2026-06-05T04:40:06.76817Z","end":"2026-06-05T04:40:06.898689Z","steps":["trace[876754525] 'agreement among raft nodes before linearized reading' (duration: 130.390733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.898773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.996059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.898874Z","caller":"traceutil/trace.go:171","msg":"trace[123035783] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"106.122411ms","start":"2026-06-05T04:40:06.792724Z","end":"2026-06-05T04:40:06.898847Z","steps":["trace[123035783] 'agreement among raft nodes before linearized reading' (duration: 105.909157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.898907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.496648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.898931Z","caller":"traceutil/trace.go:171","msg":"trace[727732857] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"107.552028ms","start":"2026-06-05T04:40:06.791371Z","end":"2026-06-05T04:40:06.898923Z","steps":["trace[727732857] 'agreement among raft nodes before linearized reading' (duration: 107.518098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.898993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.475926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:40:06.899019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.806944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.899035Z","caller":"traceutil/trace.go:171","msg":"trace[1884614824] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"107.824114ms","start":"2026-06-05T04:40:06.791207Z","end":"2026-06-05T04:40:06.899031Z","steps":["trace[1884614824] 'agreement among raft nodes before linearized reading' (duration: 107.795674ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.89902Z","caller":"traceutil/trace.go:171","msg":"trace[1287877298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"131.571737ms","start":"2026-06-05T04:40:06.767441Z","end":"2026-06-05T04:40:06.899012Z","steps":["trace[1287877298] 'agreement among raft nodes before linearized reading' (duration: 131.489835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.899158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.637021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.899177Z","caller":"traceutil/trace.go:171","msg":"trace[1788362593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:598; }","duration":"185.677972ms","start":"2026-06-05T04:40:06.713495Z","end":"2026-06-05T04:40:06.899173Z","steps":["trace[1788362593] 'agreement among raft nodes before linearized reading' (duration: 185.649211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.899222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.705433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.899243Z","caller":"traceutil/trace.go:171","msg":"trace[157163855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:598; }","duration":"185.743413ms","start":"2026-06-05T04:40:06.713495Z","end":"2026-06-05T04:40:06.899238Z","steps":["trace[157163855] 'agreement among raft nodes before linearized reading' (duration: 185.707062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.899262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.830861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.89928Z","caller":"traceutil/trace.go:171","msg":"trace[1895160532] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:598; }","duration":"131.862233ms","start":"2026-06-05T04:40:06.767414Z","end":"2026-06-05T04:40:06.899276Z","steps":["trace[1895160532] 'agreement among raft nodes before linearized reading' (duration: 131.834832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.899358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.865467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.899377Z","caller":"traceutil/trace.go:171","msg":"trace[540684572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:598; }","duration":"184.924928ms","start":"2026-06-05T04:40:06.714447Z","end":"2026-06-05T04:40:06.899372Z","steps":["trace[540684572] 'agreement among raft nodes before linearized reading' (duration: 184.893977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:06.89936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.893599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:06.899484Z","caller":"traceutil/trace.go:171","msg":"trace[1403995339] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:598; }","duration":"221.028922ms","start":"2026-06-05T04:40:06.678448Z","end":"2026-06-05T04:40:06.899477Z","steps":["trace[1403995339] 'agreement among raft nodes before linearized reading' (duration: 220.883699ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:06.899735Z","caller":"traceutil/trace.go:171","msg":"trace[892606593] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"191.606739ms","start":"2026-06-05T04:40:06.708121Z","end":"2026-06-05T04:40:06.899727Z","steps":["trace[892606593] 'process raft request' (duration: 189.728512ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:07.331993Z","caller":"traceutil/trace.go:171","msg":"trace[1523220019] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"357.973014ms","start":"2026-06-05T04:40:06.974Z","end":"2026-06-05T04:40:07.331973Z","steps":["trace[1523220019] 'process raft request' (duration: 348.594572ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:07.332099Z","caller":"traceutil/trace.go:171","msg":"trace[693570103] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"296.423322ms","start":"2026-06-05T04:40:07.035656Z","end":"2026-06-05T04:40:07.33208Z","steps":["trace[693570103] 'read index received' (duration: 287.009509ms)","trace[693570103] 'applied index is now lower than readState.Index' (duration: 9.411893ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:07.332219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:06.973979Z","time spent":"358.080026ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:40:07.332332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.645257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.332471Z","caller":"traceutil/trace.go:171","msg":"trace[1512312081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"296.7974ms","start":"2026-06-05T04:40:07.035619Z","end":"2026-06-05T04:40:07.332416Z","steps":["trace[1512312081] 'agreement among raft nodes before linearized reading' (duration: 296.535845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.332596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.890182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:40:07.33265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.191418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.332666Z","caller":"traceutil/trace.go:171","msg":"trace[450151948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:600; }","duration":"196.001244ms","start":"2026-06-05T04:40:07.136649Z","end":"2026-06-05T04:40:07.33265Z","steps":["trace[450151948] 'agreement among raft nodes before linearized reading' (duration: 195.874071ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:07.332705Z","caller":"traceutil/trace.go:171","msg":"trace[320058149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:600; }","duration":"113.25978ms","start":"2026-06-05T04:40:07.219417Z","end":"2026-06-05T04:40:07.332677Z","steps":["trace[320058149] 'agreement among raft nodes before linearized reading' (duration: 113.186499ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:07.332816Z","caller":"traceutil/trace.go:171","msg":"trace[1911142022] transaction","detail":"{read_only:false; number_of_response:1; response_revision:600; }","duration":"209.166002ms","start":"2026-06-05T04:40:07.123643Z","end":"2026-06-05T04:40:07.332809Z","steps":["trace[1911142022] 'process raft request' (duration: 208.444287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.332952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.03171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333018Z","caller":"traceutil/trace.go:171","msg":"trace[1856058829] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:600; }","duration":"145.108171ms","start":"2026-06-05T04:40:07.187891Z","end":"2026-06-05T04:40:07.332999Z","steps":["trace[1856058829] 'agreement among raft nodes before linearized reading' (duration: 145.01604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.333168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.623217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333192Z","caller":"traceutil/trace.go:171","msg":"trace[1319486844] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:600; }","duration":"113.678508ms","start":"2026-06-05T04:40:07.219507Z","end":"2026-06-05T04:40:07.333185Z","steps":["trace[1319486844] 'agreement among raft nodes before linearized reading' (duration: 113.645997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.333306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.820675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333365Z","caller":"traceutil/trace.go:171","msg":"trace[677364783] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:600; }","duration":"145.901316ms","start":"2026-06-05T04:40:07.187449Z","end":"2026-06-05T04:40:07.333351Z","steps":["trace[677364783] 'agreement among raft nodes before linearized reading' (duration: 145.814914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.333561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.326605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333623Z","caller":"traceutil/trace.go:171","msg":"trace[1075694811] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:600; }","duration":"146.401366ms","start":"2026-06-05T04:40:07.187204Z","end":"2026-06-05T04:40:07.333605Z","steps":["trace[1075694811] 'agreement among raft nodes before linearized reading' (duration: 146.316264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.333814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.478665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333836Z","caller":"traceutil/trace.go:171","msg":"trace[465541945] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:600; }","duration":"174.547926ms","start":"2026-06-05T04:40:07.159283Z","end":"2026-06-05T04:40:07.333831Z","steps":["trace[465541945] 'agreement among raft nodes before linearized reading' (duration: 174.512805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.33387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.602287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:40:07.333921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.76481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333941Z","caller":"traceutil/trace.go:171","msg":"trace[1926517496] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:600; }","duration":"173.838041ms","start":"2026-06-05T04:40:07.160098Z","end":"2026-06-05T04:40:07.333937Z","steps":["trace[1926517496] 'agreement among raft nodes before linearized reading' (duration: 173.807571ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:07.333931Z","caller":"traceutil/trace.go:171","msg":"trace[918640361] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:600; }","duration":"174.662558ms","start":"2026-06-05T04:40:07.159251Z","end":"2026-06-05T04:40:07.333913Z","steps":["trace[918640361] 'agreement among raft nodes before linearized reading' (duration: 174.582166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:07.333801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.056725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:07.333999Z","caller":"traceutil/trace.go:171","msg":"trace[699901202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:600; }","duration":"197.285549ms","start":"2026-06-05T04:40:07.136697Z","end":"2026-06-05T04:40:07.333982Z","steps":["trace[699901202] 'agreement among raft nodes before linearized reading' (duration: 197.057315ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:12.661484Z","caller":"traceutil/trace.go:171","msg":"trace[229973503] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"112.530456ms","start":"2026-06-05T04:40:12.548918Z","end":"2026-06-05T04:40:12.661448Z","steps":["trace[229973503] 'read index received' (duration: 109.552918ms)","trace[229973503] 'applied index is now lower than readState.Index' (duration: 2.976378ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:12.661577Z","caller":"traceutil/trace.go:171","msg":"trace[850041982] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"126.411468ms","start":"2026-06-05T04:40:12.535112Z","end":"2026-06-05T04:40:12.661523Z","steps":["trace[850041982] 'process raft request' (duration: 124.580081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:12.661751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.801471ms","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-05T04:40:12.661825Z","caller":"traceutil/trace.go:171","msg":"trace[2091119491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"112.949574ms","start":"2026-06-05T04:40:12.548855Z","end":"2026-06-05T04:40:12.661804Z","steps":["trace[2091119491] 'agreement among raft nodes before linearized reading' (duration: 112.76139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:12.900535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.702529ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:40:12.900695Z","caller":"traceutil/trace.go:171","msg":"trace[66344820] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"187.959808ms","start":"2026-06-05T04:40:12.712709Z","end":"2026-06-05T04:40:12.900669Z","steps":["trace[66344820] 'process raft request' (duration: 56.981322ms)","trace[66344820] 'compare' (duration: 130.473745ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:13.741258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.949402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:13.741348Z","caller":"traceutil/trace.go:171","msg":"trace[1373600646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"711.103085ms","start":"2026-06-05T04:40:13.030224Z","end":"2026-06-05T04:40:13.741327Z","steps":["trace[1373600646] 'range keys from in-memory index tree' (duration: 710.796229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:13.741394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:13.0302Z","time spent":"711.184786ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:40:13.752025Z","caller":"traceutil/trace.go:171","msg":"trace[593320072] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"242.175566ms","start":"2026-06-05T04:40:13.509809Z","end":"2026-06-05T04:40:13.751984Z","steps":["trace[593320072] 'process raft request' (duration: 241.872179ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:13.751807Z","caller":"traceutil/trace.go:171","msg":"trace[438891882] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"443.169507ms","start":"2026-06-05T04:40:13.30859Z","end":"2026-06-05T04:40:13.751759Z","steps":["trace[438891882] 'process raft request' (duration: 442.346361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:13.752284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:13.308555Z","time spent":"443.630837ms","remote":"127.0.0.1:33548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:40:15.37748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.255549ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-06-05T04:40:15.399557Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102828484906869,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T04:40:15.406128Z","caller":"traceutil/trace.go:171","msg":"trace[176788142] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"687.196059ms","start":"2026-06-05T04:40:14.718885Z","end":"2026-06-05T04:40:15.406081Z","steps":["trace[176788142] 'process raft request' (duration: 686.484365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.406325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.969342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ssv84\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-05T04:40:15.40638Z","caller":"traceutil/trace.go:171","msg":"trace[320337990] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ssv84; range_end:; response_count:1; response_revision:640; }","duration":"507.081764ms","start":"2026-06-05T04:40:14.899286Z","end":"2026-06-05T04:40:15.406368Z","steps":["trace[320337990] 'agreement among raft nodes before linearized reading' (duration: 506.909251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.406419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:14.899264Z","time spent":"507.146366ms","remote":"127.0.0.1:33634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-ssv84\" "} {"level":"warn","ts":"2026-06-05T04:40:15.406575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:14.718848Z","time spent":"687.414184ms","remote":"127.0.0.1:33548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:40:15.40658Z","caller":"traceutil/trace.go:171","msg":"trace[1435814925] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"686.069217ms","start":"2026-06-05T04:40:14.72036Z","end":"2026-06-05T04:40:15.406429Z","steps":["trace[1435814925] 'process raft request' (duration: 685.632359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.40696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:14.720342Z","time spent":"686.514465ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:40:15.406626Z","caller":"traceutil/trace.go:171","msg":"trace[335267572] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"686.113778ms","start":"2026-06-05T04:40:14.720415Z","end":"2026-06-05T04:40:15.406529Z","steps":["trace[335267572] 'process raft request' (duration: 685.630509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.407224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:14.720407Z","time spent":"686.653629ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:40:15.406147Z","caller":"traceutil/trace.go:171","msg":"trace[1302143145] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:662; }","duration":"506.773538ms","start":"2026-06-05T04:40:14.899346Z","end":"2026-06-05T04:40:15.40612Z","steps":["trace[1302143145] 'read index received' (duration: 505.741348ms)","trace[1302143145] 'applied index is now lower than readState.Index' (duration: 1.03105ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:15.406715Z","caller":"traceutil/trace.go:171","msg":"trace[692487517] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"685.855932ms","start":"2026-06-05T04:40:14.720846Z","end":"2026-06-05T04:40:15.406702Z","steps":["trace[692487517] 'process raft request' (duration: 685.23165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.407462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:14.72084Z","time spent":"686.538156ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:40:15.407516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.377194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:15.407559Z","caller":"traceutil/trace.go:171","msg":"trace[1443359312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"376.476757ms","start":"2026-06-05T04:40:15.031068Z","end":"2026-06-05T04:40:15.407545Z","steps":["trace[1443359312] 'agreement among raft nodes before linearized reading' (duration: 376.396526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:15.407594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:15.031035Z","time spent":"376.552818ms","remote":"127.0.0.1:33438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:40:16.532534Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102828484906876,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:40:16.835815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347985411s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:40:16.835984Z","caller":"traceutil/trace.go:171","msg":"trace[1639203963] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.415966677s","start":"2026-06-05T04:40:15.419984Z","end":"2026-06-05T04:40:16.83595Z","steps":["trace[1639203963] 'process raft request' (duration: 67.70603ms)","trace[1639203963] 'compare' (duration: 1.347317778s)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:16.83606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:15.419963Z","time spent":"1.416064769s","remote":"127.0.0.1:33634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:40:17.033233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102828484906876,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:40:17.04589Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.113496095s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T04:40:17.108288Z","caller":"traceutil/trace.go:171","msg":"trace[18870659] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"1.076696628s","start":"2026-06-05T04:40:16.031569Z","end":"2026-06-05T04:40:17.108265Z","steps":["trace[18870659] 'read index received' (duration: 1.015724278s)","trace[18870659] 'applied index is now lower than readState.Index' (duration: 60.97151ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:17.108419Z","caller":"traceutil/trace.go:171","msg":"trace[1139149700] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.637367027s","start":"2026-06-05T04:40:15.471017Z","end":"2026-06-05T04:40:17.108384Z","steps":["trace[1139149700] 'process raft request' (duration: 1.576346366s)","trace[1139149700] 'compare' (duration: 60.772357ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:17.108594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:15.470987Z","time spent":"1.63753863s","remote":"127.0.0.1:33832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:40:17.108483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.076871461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:40:17.10869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.58114ms","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-05T04:40:17.108727Z","caller":"traceutil/trace.go:171","msg":"trace[1704114013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"391.659061ms","start":"2026-06-05T04:40:16.717056Z","end":"2026-06-05T04:40:17.108715Z","steps":["trace[1704114013] 'agreement among raft nodes before linearized reading' (duration: 391.454978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:17.108762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:16.717035Z","time spent":"391.719073ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:40:17.108736Z","caller":"traceutil/trace.go:171","msg":"trace[751783261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.077200147s","start":"2026-06-05T04:40:16.031493Z","end":"2026-06-05T04:40:17.108693Z","steps":["trace[751783261] 'agreement among raft nodes before linearized reading' (duration: 1.076887661s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:17.108861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:16.031467Z","time spent":"1.077349379s","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:40:17.550898Z","caller":"traceutil/trace.go:171","msg":"trace[1119504654] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"136.543785ms","start":"2026-06-05T04:40:17.414329Z","end":"2026-06-05T04:40:17.550872Z","steps":["trace[1119504654] 'process raft request' (duration: 136.369572ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:17.575543Z","caller":"traceutil/trace.go:171","msg":"trace[11412368] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"160.792557ms","start":"2026-06-05T04:40:17.414708Z","end":"2026-06-05T04:40:17.575501Z","steps":["trace[11412368] 'process raft request' (duration: 160.570453ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:17.575639Z","caller":"traceutil/trace.go:171","msg":"trace[1586409601] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"160.42879ms","start":"2026-06-05T04:40:17.415178Z","end":"2026-06-05T04:40:17.575607Z","steps":["trace[1586409601] 'process raft request' (duration: 160.218316ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:18.210392Z","caller":"traceutil/trace.go:171","msg":"trace[656912034] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"135.501315ms","start":"2026-06-05T04:40:18.074858Z","end":"2026-06-05T04:40:18.210359Z","steps":["trace[656912034] 'process raft request' (duration: 131.981635ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:22.21019Z","caller":"traceutil/trace.go:171","msg":"trace[297624299] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"109.561669ms","start":"2026-06-05T04:40:22.100607Z","end":"2026-06-05T04:40:22.210169Z","steps":["trace[297624299] 'process raft request' (duration: 106.61445ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:35.467458Z","caller":"traceutil/trace.go:171","msg":"trace[719493147] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"707.236929ms","start":"2026-06-05T04:40:34.760194Z","end":"2026-06-05T04:40:35.467431Z","steps":["trace[719493147] 'process raft request' (duration: 707.068196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:35.467707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:34.760164Z","time spent":"707.459503ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:40:35.571592Z","caller":"traceutil/trace.go:171","msg":"trace[2086141608] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:842; }","duration":"541.089578ms","start":"2026-06-05T04:40:35.030477Z","end":"2026-06-05T04:40:35.571567Z","steps":["trace[2086141608] 'read index received' (duration: 436.762581ms)","trace[2086141608] 'applied index is now lower than readState.Index' (duration: 104.325737ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:35.571626Z","caller":"traceutil/trace.go:171","msg":"trace[2087726697] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"542.955005ms","start":"2026-06-05T04:40:35.028648Z","end":"2026-06-05T04:40:35.571603Z","steps":["trace[2087726697] 'process raft request' (duration: 542.744091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:35.571722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.226882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:40:35.571785Z","caller":"traceutil/trace.go:171","msg":"trace[1639794332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"541.342264ms","start":"2026-06-05T04:40:35.030428Z","end":"2026-06-05T04:40:35.57177Z","steps":["trace[1639794332] 'agreement among raft nodes before linearized reading' (duration: 541.240562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:35.57178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:35.02859Z","time spent":"543.096138ms","remote":"127.0.0.1:33688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:40:35.571832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:35.030401Z","time spent":"541.422706ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:40:35.57207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.688997ms","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-05T04:40:35.572133Z","caller":"traceutil/trace.go:171","msg":"trace[1986734462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:813; }","duration":"208.784739ms","start":"2026-06-05T04:40:35.363332Z","end":"2026-06-05T04:40:35.572117Z","steps":["trace[1986734462] 'agreement among raft nodes before linearized reading' (duration: 208.418952ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:49.494971Z","caller":"traceutil/trace.go:171","msg":"trace[1272858643] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"200.658222ms","start":"2026-06-05T04:40:49.294283Z","end":"2026-06-05T04:40:49.494941Z","steps":["trace[1272858643] 'process raft request' (duration: 200.387107ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:49.912841Z","caller":"traceutil/trace.go:171","msg":"trace[875053457] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:985; }","duration":"343.430897ms","start":"2026-06-05T04:40:49.56935Z","end":"2026-06-05T04:40:49.912781Z","steps":["trace[875053457] 'read index received' (duration: 288.902746ms)","trace[875053457] 'applied index is now lower than readState.Index' (duration: 54.52675ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:49.913003Z","caller":"traceutil/trace.go:171","msg":"trace[1392890923] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"408.823227ms","start":"2026-06-05T04:40:49.504152Z","end":"2026-06-05T04:40:49.912975Z","steps":["trace[1392890923] 'process raft request' (duration: 354.076923ms)","trace[1392890923] 'compare' (duration: 54.054971ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:40:49.913138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:49.504128Z","time spent":"408.94278ms","remote":"127.0.0.1:33634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:40:49.913158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.797223ms","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-05T04:40:49.913227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.17669ms","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-05T04:40:49.913237Z","caller":"traceutil/trace.go:171","msg":"trace[1174565369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"343.924157ms","start":"2026-06-05T04:40:49.569293Z","end":"2026-06-05T04:40:49.913217Z","steps":["trace[1174565369] 'agreement among raft nodes before linearized reading' (duration: 343.676151ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:49.913281Z","caller":"traceutil/trace.go:171","msg":"trace[390866712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:952; }","duration":"275.272762ms","start":"2026-06-05T04:40:49.637995Z","end":"2026-06-05T04:40:49.913268Z","steps":["trace[390866712] 'agreement among raft nodes before linearized reading' (duration: 275.080607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:49.913292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:49.56927Z","time spent":"344.012678ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T04:40:49.913563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.627093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T04:40:49.913592Z","caller":"traceutil/trace.go:171","msg":"trace[912375828] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:952; }","duration":"214.697125ms","start":"2026-06-05T04:40:49.698887Z","end":"2026-06-05T04:40:49.913584Z","steps":["trace[912375828] 'agreement among raft nodes before linearized reading' (duration: 214.623893ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.167545Z","caller":"traceutil/trace.go:171","msg":"trace[316896748] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"242.549915ms","start":"2026-06-05T04:40:49.924972Z","end":"2026-06-05T04:40:50.167522Z","steps":["trace[316896748] 'process raft request' (duration: 242.400422ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.167787Z","caller":"traceutil/trace.go:171","msg":"trace[1372433083] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"242.482894ms","start":"2026-06-05T04:40:49.92528Z","end":"2026-06-05T04:40:50.167763Z","steps":["trace[1372433083] 'process raft request' (duration: 242.189249ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.167798Z","caller":"traceutil/trace.go:171","msg":"trace[818329611] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"242.706078ms","start":"2026-06-05T04:40:49.925064Z","end":"2026-06-05T04:40:50.16777Z","steps":["trace[818329611] 'process raft request' (duration: 242.362702ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.167925Z","caller":"traceutil/trace.go:171","msg":"trace[158825608] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"243.115846ms","start":"2026-06-05T04:40:49.924789Z","end":"2026-06-05T04:40:50.167905Z","steps":["trace[158825608] 'process raft request' (duration: 242.333191ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.168126Z","caller":"traceutil/trace.go:171","msg":"trace[1171557980] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"242.778841ms","start":"2026-06-05T04:40:49.925335Z","end":"2026-06-05T04:40:50.168114Z","steps":["trace[1171557980] 'process raft request' (duration: 242.346632ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.168428Z","caller":"traceutil/trace.go:171","msg":"trace[1764505096] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"242.997964ms","start":"2026-06-05T04:40:49.925419Z","end":"2026-06-05T04:40:50.168417Z","steps":["trace[1764505096] 'process raft request' (duration: 242.899012ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.168523Z","caller":"traceutil/trace.go:171","msg":"trace[1618319834] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"239.791681ms","start":"2026-06-05T04:40:49.928717Z","end":"2026-06-05T04:40:50.168508Z","steps":["trace[1618319834] 'process raft request' (duration: 239.670459ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.168479Z","caller":"traceutil/trace.go:171","msg":"trace[859407022] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"243.073726ms","start":"2026-06-05T04:40:49.925365Z","end":"2026-06-05T04:40:50.168438Z","steps":["trace[859407022] 'process raft request' (duration: 242.689678ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.351804Z","caller":"traceutil/trace.go:171","msg":"trace[1421038725] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"201.394325ms","start":"2026-06-05T04:40:50.150394Z","end":"2026-06-05T04:40:50.351788Z","steps":["trace[1421038725] 'process raft request' (duration: 201.357444ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:40:50.351841Z","caller":"traceutil/trace.go:171","msg":"trace[652701448] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"381.986896ms","start":"2026-06-05T04:40:49.96984Z","end":"2026-06-05T04:40:50.351827Z","steps":["trace[652701448] 'process raft request' (duration: 381.644439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:50.351943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:40:49.969814Z","time spent":"382.061938ms","remote":"127.0.0.1:33480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:40:50.356185Z","caller":"traceutil/trace.go:171","msg":"trace[1413296552] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:995; }","duration":"103.638245ms","start":"2026-06-05T04:40:50.252527Z","end":"2026-06-05T04:40:50.356165Z","steps":["trace[1413296552] 'read index received' (duration: 98.932164ms)","trace[1413296552] 'applied index is now lower than readState.Index' (duration: 4.705081ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:40:50.356245Z","caller":"traceutil/trace.go:171","msg":"trace[1360802715] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"179.275905ms","start":"2026-06-05T04:40:50.17695Z","end":"2026-06-05T04:40:50.356226Z","steps":["trace[1360802715] 'process raft request' (duration: 179.104172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:40:50.356396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.851629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-w5rjc\" ","response":"range_response_count:1 size:2273"} {"level":"info","ts":"2026-06-05T04:40:50.356431Z","caller":"traceutil/trace.go:171","msg":"trace[462068353] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-w5rjc; range_end:; response_count:1; response_revision:963; }","duration":"103.89953ms","start":"2026-06-05T04:40:50.252519Z","end":"2026-06-05T04:40:50.356419Z","steps":["trace[462068353] 'agreement among raft nodes before linearized reading' (duration: 103.774207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:10.236946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.85477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:41:10.237712Z","caller":"traceutil/trace.go:171","msg":"trace[181568709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"209.218177ms","start":"2026-06-05T04:41:10.027983Z","end":"2026-06-05T04:41:10.237202Z","steps":["trace[181568709] 'range keys from in-memory index tree' (duration: 208.712817ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:10.669004Z","caller":"traceutil/trace.go:171","msg":"trace[1137027025] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"267.022231ms","start":"2026-06-05T04:41:10.401952Z","end":"2026-06-05T04:41:10.668975Z","steps":["trace[1137027025] 'read index received' (duration: 266.737774ms)","trace[1137027025] 'applied index is now lower than readState.Index' (duration: 283.847µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:10.669192Z","caller":"traceutil/trace.go:171","msg":"trace[1532116780] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"364.483826ms","start":"2026-06-05T04:41:10.304612Z","end":"2026-06-05T04:41:10.669096Z","steps":["trace[1532116780] 'process raft request' (duration: 364.18458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:10.669405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.415778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T04:41:10.669443Z","caller":"traceutil/trace.go:171","msg":"trace[776575372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1034; }","duration":"267.53189ms","start":"2026-06-05T04:41:10.401902Z","end":"2026-06-05T04:41:10.669434Z","steps":["trace[776575372] 'agreement among raft nodes before linearized reading' (duration: 267.196994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:10.670544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.304573Z","time spent":"365.833573ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:41:11.387858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.061037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:41:11.388101Z","caller":"traceutil/trace.go:171","msg":"trace[91246430] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1073; }","duration":"719.001347ms","start":"2026-06-05T04:41:10.669082Z","end":"2026-06-05T04:41:11.388083Z","steps":["trace[91246430] 'read index received' (duration: 86.536732ms)","trace[91246430] 'applied index is now lower than readState.Index' (duration: 632.463385ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:11.388207Z","caller":"traceutil/trace.go:171","msg":"trace[1107789335] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"954.295111ms","start":"2026-06-05T04:41:10.433897Z","end":"2026-06-05T04:41:11.388193Z","steps":["trace[1107789335] 'process raft request' (duration: 321.816446ms)","trace[1107789335] 'compare' (duration: 631.742451ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:41:11.388268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.433876Z","time spent":"954.358643ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:41:11.388308Z","caller":"traceutil/trace.go:171","msg":"trace[364883635] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"710.474692ms","start":"2026-06-05T04:41:10.677816Z","end":"2026-06-05T04:41:11.388291Z","steps":["trace[364883635] 'process raft request' (duration: 710.217077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:11.388387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.67779Z","time spent":"710.557073ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:41:11.388541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.5152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:41:11.388599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.853756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-05T04:41:11.38857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.083152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:41:11.388624Z","caller":"traceutil/trace.go:171","msg":"trace[586110186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"359.614952ms","start":"2026-06-05T04:41:11.028987Z","end":"2026-06-05T04:41:11.388602Z","steps":["trace[586110186] 'agreement among raft nodes before linearized reading' (duration: 359.418127ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:11.38865Z","caller":"traceutil/trace.go:171","msg":"trace[505473751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1036; }","duration":"985.928337ms","start":"2026-06-05T04:41:10.402707Z","end":"2026-06-05T04:41:11.388636Z","steps":["trace[505473751] 'agreement among raft nodes before linearized reading' (duration: 985.674502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:11.388643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.221993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:41:11.388692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.402695Z","time spent":"985.989978ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:41:11.38868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:11.028926Z","time spent":"359.746164ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:41:11.388682Z","caller":"traceutil/trace.go:171","msg":"trace[2003501046] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1036; }","duration":"981.219605ms","start":"2026-06-05T04:41:10.407435Z","end":"2026-06-05T04:41:11.388655Z","steps":["trace[2003501046] 'agreement among raft nodes before linearized reading' (duration: 980.942439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:11.389068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.407385Z","time spent":"981.659273ms","remote":"127.0.0.1:33760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:41:11.388624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.289024ms","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-05T04:41:11.389178Z","caller":"traceutil/trace.go:171","msg":"trace[719198570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1036; }","duration":"986.881335ms","start":"2026-06-05T04:41:10.402284Z","end":"2026-06-05T04:41:11.389165Z","steps":["trace[719198570] 'agreement among raft nodes before linearized reading' (duration: 986.245293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:11.389219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.402262Z","time spent":"986.945366ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-05T04:41:11.388728Z","caller":"traceutil/trace.go:171","msg":"trace[829726794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"986.337525ms","start":"2026-06-05T04:41:10.40237Z","end":"2026-06-05T04:41:11.388707Z","steps":["trace[829726794] 'agreement among raft nodes before linearized reading' (duration: 985.984727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:11.389281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:10.402361Z","time spent":"986.905125ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:41:11.562778Z","caller":"traceutil/trace.go:171","msg":"trace[1482302909] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"170.185198ms","start":"2026-06-05T04:41:11.392561Z","end":"2026-06-05T04:41:11.562747Z","steps":["trace[1482302909] 'process raft request' (duration: 169.914713ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:11.563515Z","caller":"traceutil/trace.go:171","msg":"trace[683761889] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"170.103427ms","start":"2026-06-05T04:41:11.393395Z","end":"2026-06-05T04:41:11.563499Z","steps":["trace[683761889] 'process raft request' (duration: 170.064057ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:11.56358Z","caller":"traceutil/trace.go:171","msg":"trace[1925264378] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"170.552685ms","start":"2026-06-05T04:41:11.392985Z","end":"2026-06-05T04:41:11.563538Z","steps":["trace[1925264378] 'process raft request' (duration: 170.385851ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:13.547283Z","caller":"traceutil/trace.go:171","msg":"trace[1694664744] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"151.274621ms","start":"2026-06-05T04:41:13.395986Z","end":"2026-06-05T04:41:13.547261Z","steps":["trace[1694664744] 'process raft request' (duration: 119.875061ms)","trace[1694664744] 'compare' (duration: 31.014353ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:35.995873Z","caller":"traceutil/trace.go:171","msg":"trace[1790581065] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"479.595914ms","start":"2026-06-05T04:41:35.516253Z","end":"2026-06-05T04:41:35.995849Z","steps":["trace[1790581065] 'process raft request' (duration: 479.44727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:35.996014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.516236Z","time spent":"479.706086ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:41:36.544034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.382436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:41:36.544142Z","caller":"traceutil/trace.go:171","msg":"trace[1440137876] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1157; }","duration":"847.584727ms","start":"2026-06-05T04:41:35.696541Z","end":"2026-06-05T04:41:36.544126Z","steps":["trace[1440137876] 'read index received' (duration: 299.472422ms)","trace[1440137876] 'applied index is now lower than readState.Index' (duration: 548.110985ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:36.544167Z","caller":"traceutil/trace.go:171","msg":"trace[30565668] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"961.340007ms","start":"2026-06-05T04:41:35.5828Z","end":"2026-06-05T04:41:36.54414Z","steps":["trace[30565668] 'process raft request' (duration: 638.769347ms)","trace[30565668] 'compare' (duration: 322.110631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:41:36.544257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.721449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:41:36.544312Z","caller":"traceutil/trace.go:171","msg":"trace[1774021291] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1114; }","duration":"847.77749ms","start":"2026-06-05T04:41:35.696523Z","end":"2026-06-05T04:41:36.5443Z","steps":["trace[1774021291] 'agreement among raft nodes before linearized reading' (duration: 847.691358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.544315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.582771Z","time spent":"961.45515ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:41:36.544348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.696501Z","time spent":"847.837441ms","remote":"127.0.0.1:33774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:41:36.544655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.814732ms","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-05T04:41:36.544681Z","caller":"traceutil/trace.go:171","msg":"trace[1721925816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1114; }","duration":"829.879203ms","start":"2026-06-05T04:41:35.714794Z","end":"2026-06-05T04:41:36.544673Z","steps":["trace[1721925816] 'agreement among raft nodes before linearized reading' (duration: 829.7832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.544703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.714775Z","time spent":"829.923444ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T04:41:36.544714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.29837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:41:36.544754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.623393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:41:36.544791Z","caller":"traceutil/trace.go:171","msg":"trace[1422446008] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1114; }","duration":"247.666144ms","start":"2026-06-05T04:41:36.297116Z","end":"2026-06-05T04:41:36.544782Z","steps":["trace[1422446008] 'agreement among raft nodes before linearized reading' (duration: 247.580993ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:36.544802Z","caller":"traceutil/trace.go:171","msg":"trace[389864862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1114; }","duration":"511.443893ms","start":"2026-06-05T04:41:36.033336Z","end":"2026-06-05T04:41:36.544779Z","steps":["trace[389864862] 'agreement among raft nodes before linearized reading' (duration: 511.274009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.544838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.024917ms","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-05T04:41:36.544852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:36.033313Z","time spent":"511.530615ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:41:36.544863Z","caller":"traceutil/trace.go:171","msg":"trace[492665559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1114; }","duration":"809.107868ms","start":"2026-06-05T04:41:35.735747Z","end":"2026-06-05T04:41:36.544855Z","steps":["trace[492665559] 'agreement among raft nodes before linearized reading' (duration: 809.045077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.544902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.735705Z","time spent":"809.19245ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T04:41:36.544944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.643109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:41:36.544976Z","caller":"traceutil/trace.go:171","msg":"trace[290628388] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1114; }","duration":"454.735081ms","start":"2026-06-05T04:41:36.090231Z","end":"2026-06-05T04:41:36.544966Z","steps":["trace[290628388] 'agreement among raft nodes before linearized reading' (duration: 454.657509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:36.090189Z","time spent":"454.805521ms","remote":"127.0.0.1:33790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:41:36.545012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.119447ms","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-05T04:41:36.545028Z","caller":"traceutil/trace.go:171","msg":"trace[1499982232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1114; }","duration":"813.155408ms","start":"2026-06-05T04:41:35.731867Z","end":"2026-06-05T04:41:36.545022Z","steps":["trace[1499982232] 'agreement among raft nodes before linearized reading' (duration: 813.107457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.545044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.731857Z","time spent":"813.183148ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:41:36.545044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.499177ms","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-05T04:41:36.545118Z","caller":"traceutil/trace.go:171","msg":"trace[333710011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1114; }","duration":"827.603758ms","start":"2026-06-05T04:41:35.717495Z","end":"2026-06-05T04:41:36.545099Z","steps":["trace[333710011] 'agreement among raft nodes before linearized reading' (duration: 827.371564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:36.54516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:35.717484Z","time spent":"827.667409ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T04:41:38.201458Z","caller":"traceutil/trace.go:171","msg":"trace[1375287022] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1163; }","duration":"170.460729ms","start":"2026-06-05T04:41:38.030976Z","end":"2026-06-05T04:41:38.201436Z","steps":["trace[1375287022] 'read index received' (duration: 170.262755ms)","trace[1375287022] 'applied index is now lower than readState.Index' (duration: 197.214µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:38.201531Z","caller":"traceutil/trace.go:171","msg":"trace[1749868416] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"199.730698ms","start":"2026-06-05T04:41:38.001762Z","end":"2026-06-05T04:41:38.201492Z","steps":["trace[1749868416] 'process raft request' (duration: 199.509734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:38.201613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.636753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:41:38.201654Z","caller":"traceutil/trace.go:171","msg":"trace[1694547802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1120; }","duration":"170.743065ms","start":"2026-06-05T04:41:38.030897Z","end":"2026-06-05T04:41:38.201641Z","steps":["trace[1694547802] 'agreement among raft nodes before linearized reading' (duration: 170.659913ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:38.849523Z","caller":"traceutil/trace.go:171","msg":"trace[607177405] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1164; }","duration":"272.825627ms","start":"2026-06-05T04:41:38.576682Z","end":"2026-06-05T04:41:38.849508Z","steps":["trace[607177405] 'read index received' (duration: 272.671884ms)","trace[607177405] 'applied index is now lower than readState.Index' (duration: 152.913µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:38.849576Z","caller":"traceutil/trace.go:171","msg":"trace[205041232] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"274.479559ms","start":"2026-06-05T04:41:38.575075Z","end":"2026-06-05T04:41:38.849554Z","steps":["trace[205041232] 'process raft request' (duration: 274.316036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:38.849704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.114508ms","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-05T04:41:38.849736Z","caller":"traceutil/trace.go:171","msg":"trace[1948903408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1121; }","duration":"227.21582ms","start":"2026-06-05T04:41:38.622512Z","end":"2026-06-05T04:41:38.849728Z","steps":["trace[1948903408] 'agreement among raft nodes before linearized reading' (duration: 227.089998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:38.849832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.546558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-05T04:41:38.849795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.092392ms","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":"info","ts":"2026-06-05T04:41:38.849857Z","caller":"traceutil/trace.go:171","msg":"trace[1981904483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1121; }","duration":"225.59707ms","start":"2026-06-05T04:41:38.624254Z","end":"2026-06-05T04:41:38.849851Z","steps":["trace[1981904483] 'agreement among raft nodes before linearized reading' (duration: 225.541849ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:38.849885Z","caller":"traceutil/trace.go:171","msg":"trace[2072389847] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1121; }","duration":"273.256555ms","start":"2026-06-05T04:41:38.576609Z","end":"2026-06-05T04:41:38.849866Z","steps":["trace[2072389847] 'agreement among raft nodes before linearized reading' (duration: 272.9847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:38.849925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.081818ms","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-05T04:41:38.849967Z","caller":"traceutil/trace.go:171","msg":"trace[1587150356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1121; }","duration":"227.16606ms","start":"2026-06-05T04:41:38.622791Z","end":"2026-06-05T04:41:38.849957Z","steps":["trace[1587150356] 'agreement among raft nodes before linearized reading' (duration: 227.055828ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:39.038064Z","caller":"traceutil/trace.go:171","msg":"trace[619715118] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"184.591393ms","start":"2026-06-05T04:41:38.853432Z","end":"2026-06-05T04:41:39.038024Z","steps":["trace[619715118] 'process raft request' (duration: 182.710827ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:39.039816Z","caller":"traceutil/trace.go:171","msg":"trace[1923031844] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"186.336648ms","start":"2026-06-05T04:41:38.853448Z","end":"2026-06-05T04:41:39.039785Z","steps":["trace[1923031844] 'process raft request' (duration: 186.155584ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:39.040074Z","caller":"traceutil/trace.go:171","msg":"trace[20980856] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"186.361458ms","start":"2026-06-05T04:41:38.853693Z","end":"2026-06-05T04:41:39.040055Z","steps":["trace[20980856] 'process raft request' (duration: 186.038032ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:39.04044Z","caller":"traceutil/trace.go:171","msg":"trace[1649463895] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"185.369208ms","start":"2026-06-05T04:41:38.855053Z","end":"2026-06-05T04:41:39.040422Z","steps":["trace[1649463895] 'process raft request' (duration: 184.915139ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:43.104672Z","caller":"traceutil/trace.go:171","msg":"trace[335409557] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"227.454696ms","start":"2026-06-05T04:41:42.877182Z","end":"2026-06-05T04:41:43.104636Z","steps":["trace[335409557] 'process raft request' (duration: 227.213882ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:43.212847Z","caller":"traceutil/trace.go:171","msg":"trace[2025237863] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"100.142733ms","start":"2026-06-05T04:41:43.112677Z","end":"2026-06-05T04:41:43.21282Z","steps":["trace[2025237863] 'process raft request' (duration: 100.104942ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:43.213091Z","caller":"traceutil/trace.go:171","msg":"trace[605642229] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"101.843417ms","start":"2026-06-05T04:41:43.111222Z","end":"2026-06-05T04:41:43.213065Z","steps":["trace[605642229] 'process raft request' (duration: 101.411179ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:43.213334Z","caller":"traceutil/trace.go:171","msg":"trace[941967522] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"101.099412ms","start":"2026-06-05T04:41:43.112158Z","end":"2026-06-05T04:41:43.213257Z","steps":["trace[941967522] 'process raft request' (duration: 100.584823ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:58.45708Z","caller":"traceutil/trace.go:171","msg":"trace[1341818607] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"102.535061ms","start":"2026-06-05T04:41:58.354519Z","end":"2026-06-05T04:41:58.457054Z","steps":["trace[1341818607] 'process raft request' (duration: 102.362218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:59.835789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102828484908199,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T04:41:59.879127Z","caller":"traceutil/trace.go:171","msg":"trace[1463218875] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1288; }","duration":"544.01963ms","start":"2026-06-05T04:41:59.335087Z","end":"2026-06-05T04:41:59.879106Z","steps":["trace[1463218875] 'read index received' (duration: 543.898928ms)","trace[1463218875] 'applied index is now lower than readState.Index' (duration: 119.912µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:41:59.879212Z","caller":"traceutil/trace.go:171","msg":"trace[1485129030] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"568.683339ms","start":"2026-06-05T04:41:59.310501Z","end":"2026-06-05T04:41:59.879184Z","steps":["trace[1485129030] 'process raft request' (duration: 568.467905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:59.879336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.9633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T04:41:59.879359Z","caller":"traceutil/trace.go:171","msg":"trace[307871379] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1239; }","duration":"543.017422ms","start":"2026-06-05T04:41:59.336334Z","end":"2026-06-05T04:41:59.879352Z","steps":["trace[307871379] 'agreement among raft nodes before linearized reading' (duration: 542.882328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:59.879354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.310477Z","time spent":"568.795272ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:41:59.879384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.336329Z","time spent":"543.050632ms","remote":"127.0.0.1:33718","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-05T04:41:59.879466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.372927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-05T04:41:59.879515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.671421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T04:41:59.879557Z","caller":"traceutil/trace.go:171","msg":"trace[6589538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"544.47898ms","start":"2026-06-05T04:41:59.335032Z","end":"2026-06-05T04:41:59.879511Z","steps":["trace[6589538] 'agreement among raft nodes before linearized reading' (duration: 544.177303ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:41:59.879632Z","caller":"traceutil/trace.go:171","msg":"trace[1087645705] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1239; }","duration":"175.796953ms","start":"2026-06-05T04:41:59.703797Z","end":"2026-06-05T04:41:59.879594Z","steps":["trace[1087645705] 'agreement among raft nodes before linearized reading' (duration: 175.493717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:59.879642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.001102ms","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-05T04:41:59.879707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.33501Z","time spent":"544.684974ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:41:59.879776Z","caller":"traceutil/trace.go:171","msg":"trace[1042157785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"542.205025ms","start":"2026-06-05T04:41:59.337538Z","end":"2026-06-05T04:41:59.879743Z","steps":["trace[1042157785] 'agreement among raft nodes before linearized reading' (duration: 541.806307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:41:59.879861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.337513Z","time spent":"542.331738ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:42:00.197977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.882856Z","time spent":"315.114967ms","remote":"127.0.0.1:33480","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-05T04:42:00.600411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.396453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:00.60085Z","caller":"traceutil/trace.go:171","msg":"trace[1116515770] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1289; }","duration":"570.624038ms","start":"2026-06-05T04:42:00.030203Z","end":"2026-06-05T04:42:00.600827Z","steps":["trace[1116515770] 'read index received' (duration: 167.678606ms)","trace[1116515770] 'applied index is now lower than readState.Index' (duration: 402.944122ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:00.601163Z","caller":"traceutil/trace.go:171","msg":"trace[1067889529] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"716.366337ms","start":"2026-06-05T04:41:59.884784Z","end":"2026-06-05T04:42:00.60115Z","steps":["trace[1067889529] 'process raft request' (duration: 715.783517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:00.601239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.884768Z","time spent":"716.428428ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:00.601248Z","caller":"traceutil/trace.go:171","msg":"trace[1436847590] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"716.548941ms","start":"2026-06-05T04:41:59.88466Z","end":"2026-06-05T04:42:00.601209Z","steps":["trace[1436847590] 'process raft request' (duration: 589.229289ms)","trace[1436847590] 'compare' (duration: 125.841513ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:42:00.601451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.88463Z","time spent":"716.699794ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:00.601517Z","caller":"traceutil/trace.go:171","msg":"trace[1474826371] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"715.153462ms","start":"2026-06-05T04:41:59.886348Z","end":"2026-06-05T04:42:00.601502Z","steps":["trace[1474826371] 'process raft request' (duration: 714.351197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:00.601592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:41:59.886339Z","time spent":"715.215594ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:00.601781Z","caller":"traceutil/trace.go:171","msg":"trace[833118414] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"398.589688ms","start":"2026-06-05T04:42:00.203181Z","end":"2026-06-05T04:42:00.60177Z","steps":["trace[833118414] 'process raft request' (duration: 397.590638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:00.601836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:00.203148Z","time spent":"398.65771ms","remote":"127.0.0.1:33480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:00.602096Z","caller":"traceutil/trace.go:171","msg":"trace[1761623181] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"139.447068ms","start":"2026-06-05T04:42:00.462639Z","end":"2026-06-05T04:42:00.602086Z","steps":["trace[1761623181] 'process raft request' (duration: 139.07558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:00.602231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.017645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:42:00.60229Z","caller":"traceutil/trace.go:171","msg":"trace[1279894561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"572.144217ms","start":"2026-06-05T04:42:00.030126Z","end":"2026-06-05T04:42:00.60227Z","steps":["trace[1279894561] 'agreement among raft nodes before linearized reading' (duration: 570.993255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:00.602339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:00.030092Z","time spent":"572.233919ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:42:16.773307Z","caller":"traceutil/trace.go:171","msg":"trace[111017253] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"109.583567ms","start":"2026-06-05T04:42:16.663698Z","end":"2026-06-05T04:42:16.773282Z","steps":["trace[111017253] 'read index received' (duration: 109.413624ms)","trace[111017253] 'applied index is now lower than readState.Index' (duration: 169.023µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:16.773351Z","caller":"traceutil/trace.go:171","msg":"trace[37727232] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"110.838133ms","start":"2026-06-05T04:42:16.662482Z","end":"2026-06-05T04:42:16.773321Z","steps":["trace[37727232] 'process raft request' (duration: 110.628098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:16.773553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.837383ms","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-05T04:42:16.773591Z","caller":"traceutil/trace.go:171","msg":"trace[1784879837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1313; }","duration":"109.927765ms","start":"2026-06-05T04:42:16.663651Z","end":"2026-06-05T04:42:16.773578Z","steps":["trace[1784879837] 'agreement among raft nodes before linearized reading' (duration: 109.774882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:16.773633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.091768ms","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-05T04:42:16.773657Z","caller":"traceutil/trace.go:171","msg":"trace[1149224236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1313; }","duration":"108.148229ms","start":"2026-06-05T04:42:16.665502Z","end":"2026-06-05T04:42:16.773651Z","steps":["trace[1149224236] 'agreement among raft nodes before linearized reading' (duration: 108.006616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:16.773883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.594422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T04:42:16.774001Z","caller":"traceutil/trace.go:171","msg":"trace[2051182563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1313; }","duration":"102.769914ms","start":"2026-06-05T04:42:16.671211Z","end":"2026-06-05T04:42:16.773981Z","steps":["trace[2051182563] 'agreement among raft nodes before linearized reading' (duration: 102.392567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:17.19739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.86156ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:17.197615Z","caller":"traceutil/trace.go:171","msg":"trace[2047513057] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"416.394514ms","start":"2026-06-05T04:42:16.781203Z","end":"2026-06-05T04:42:17.197598Z","steps":["trace[2047513057] 'process raft request' (duration: 416.340133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:17.197687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:16.781171Z","time spent":"416.484925ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:17.197808Z","caller":"traceutil/trace.go:171","msg":"trace[1691486992] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"416.67428ms","start":"2026-06-05T04:42:16.781103Z","end":"2026-06-05T04:42:17.197777Z","steps":["trace[1691486992] 'process raft request' (duration: 416.383953ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:17.197865Z","caller":"traceutil/trace.go:171","msg":"trace[2041403878] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"418.439594ms","start":"2026-06-05T04:42:16.779387Z","end":"2026-06-05T04:42:17.197826Z","steps":["trace[2041403878] 'process raft request' (duration: 133.055203ms)","trace[2041403878] 'compare' (duration: 284.651786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:42:17.197907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:16.781082Z","time spent":"416.766041ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:17.198058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:16.779367Z","time spent":"418.585016ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:17.544399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.187663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:17.544615Z","caller":"traceutil/trace.go:171","msg":"trace[1035084038] linearizableReadLoop","detail":"{readStateIndex:1371; appliedIndex:1370; }","duration":"263.264421ms","start":"2026-06-05T04:42:17.281323Z","end":"2026-06-05T04:42:17.544587Z","steps":["trace[1035084038] 'read index received' (duration: 39.693731ms)","trace[1035084038] 'applied index is now lower than readState.Index' (duration: 223.5678ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:17.544745Z","caller":"traceutil/trace.go:171","msg":"trace[409317076] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"401.038815ms","start":"2026-06-05T04:42:17.143682Z","end":"2026-06-05T04:42:17.544721Z","steps":["trace[409317076] 'process raft request' (duration: 177.412725ms)","trace[409317076] 'compare' (duration: 222.703743ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:42:17.54487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:17.143657Z","time spent":"401.139888ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:17.544903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.572057ms","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-05T04:42:17.544897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.535328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:42:17.544943Z","caller":"traceutil/trace.go:171","msg":"trace[1679639051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1317; }","duration":"263.647279ms","start":"2026-06-05T04:42:17.281283Z","end":"2026-06-05T04:42:17.54493Z","steps":["trace[1679639051] 'agreement among raft nodes before linearized reading' (duration: 263.439964ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:17.544985Z","caller":"traceutil/trace.go:171","msg":"trace[806435130] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1317; }","duration":"209.692892ms","start":"2026-06-05T04:42:17.33527Z","end":"2026-06-05T04:42:17.544963Z","steps":["trace[806435130] 'agreement among raft nodes before linearized reading' (duration: 209.500838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:18.52678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.223681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:18.526886Z","caller":"traceutil/trace.go:171","msg":"trace[244510549] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"544.489951ms","start":"2026-06-05T04:42:17.982378Z","end":"2026-06-05T04:42:18.526868Z","steps":["trace[244510549] 'read index received' (duration: 79.059706ms)","trace[244510549] 'applied index is now lower than readState.Index' (duration: 465.428565ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:18.526992Z","caller":"traceutil/trace.go:171","msg":"trace[1034642401] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"977.906904ms","start":"2026-06-05T04:42:17.549049Z","end":"2026-06-05T04:42:18.526956Z","steps":["trace[1034642401] 'process raft request' (duration: 512.413227ms)","trace[1034642401] 'compare' (duration: 464.997597ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:42:18.527078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.706025ms","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-05T04:42:18.527107Z","caller":"traceutil/trace.go:171","msg":"trace[2053451113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1318; }","duration":"544.734325ms","start":"2026-06-05T04:42:17.982363Z","end":"2026-06-05T04:42:18.527098Z","steps":["trace[2053451113] 'agreement among raft nodes before linearized reading' (duration: 544.592923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:18.527173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:17.549023Z","time spent":"978.045026ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:18.527342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.879727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:42:18.527387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:17.982301Z","time spent":"545.074141ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:42:18.527402Z","caller":"traceutil/trace.go:171","msg":"trace[936543020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1318; }","duration":"496.973918ms","start":"2026-06-05T04:42:18.030414Z","end":"2026-06-05T04:42:18.527388Z","steps":["trace[936543020] 'agreement among raft nodes before linearized reading' (duration: 496.882356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:18.527446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:18.030396Z","time spent":"497.035469ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:42:19.189777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102828484908378,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:42:19.506234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.505687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:19.506372Z","caller":"traceutil/trace.go:171","msg":"trace[1887319289] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1372; }","duration":"817.212375ms","start":"2026-06-05T04:42:18.689145Z","end":"2026-06-05T04:42:19.506358Z","steps":["trace[1887319289] 'read index received' (duration: 590.540744ms)","trace[1887319289] 'applied index is now lower than readState.Index' (duration: 226.671031ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:19.50644Z","caller":"traceutil/trace.go:171","msg":"trace[714883274] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"726.402311ms","start":"2026-06-05T04:42:18.78003Z","end":"2026-06-05T04:42:19.506433Z","steps":["trace[714883274] 'process raft request' (duration: 726.283258ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:19.50644Z","caller":"traceutil/trace.go:171","msg":"trace[35098599] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"974.829405ms","start":"2026-06-05T04:42:18.531595Z","end":"2026-06-05T04:42:19.506425Z","steps":["trace[35098599] 'process raft request' (duration: 747.990732ms)","trace[35098599] 'compare' (duration: 226.20474ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:42:19.506482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:18.780006Z","time spent":"726.452103ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:19.506507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:18.531574Z","time spent":"974.893036ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:19.506527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.906029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:42:19.506582Z","caller":"traceutil/trace.go:171","msg":"trace[1125653366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1320; }","duration":"475.98903ms","start":"2026-06-05T04:42:19.030575Z","end":"2026-06-05T04:42:19.506564Z","steps":["trace[1125653366] 'agreement among raft nodes before linearized reading' (duration: 475.907918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:19.506622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:19.030556Z","time spent":"476.056832ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:42:19.506646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.317718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T04:42:19.506665Z","caller":"traceutil/trace.go:171","msg":"trace[639784502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1320; }","duration":"304.344329ms","start":"2026-06-05T04:42:19.202314Z","end":"2026-06-05T04:42:19.506659Z","steps":["trace[639784502] 'agreement among raft nodes before linearized reading' (duration: 304.262967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:19.506682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:19.20231Z","time spent":"304.369099ms","remote":"127.0.0.1:33718","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-05T04:42:19.506745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.607122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:42:19.50677Z","caller":"traceutil/trace.go:171","msg":"trace[1489666680] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1320; }","duration":"817.636222ms","start":"2026-06-05T04:42:18.689127Z","end":"2026-06-05T04:42:19.506763Z","steps":["trace[1489666680] 'agreement among raft nodes before linearized reading' (duration: 817.593792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:19.506789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:18.689065Z","time spent":"817.717694ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:42:19.506865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.438019ms","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-05T04:42:19.506884Z","caller":"traceutil/trace.go:171","msg":"trace[296996162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1320; }","duration":"305.48499ms","start":"2026-06-05T04:42:19.201393Z","end":"2026-06-05T04:42:19.506878Z","steps":["trace[296996162] 'agreement among raft nodes before linearized reading' (duration: 305.430409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:19.506901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:19.201376Z","time spent":"305.521631ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:42:19.506899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.143654ms","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-05T04:42:19.506944Z","caller":"traceutil/trace.go:171","msg":"trace[968531084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1320; }","duration":"305.199015ms","start":"2026-06-05T04:42:19.201732Z","end":"2026-06-05T04:42:19.506931Z","steps":["trace[968531084] 'agreement among raft nodes before linearized reading' (duration: 305.073102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:19.506984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:19.201727Z","time spent":"305.245965ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:42:19.750497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.111089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:42:19.75075Z","caller":"traceutil/trace.go:171","msg":"trace[1717244696] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"237.728485ms","start":"2026-06-05T04:42:19.513Z","end":"2026-06-05T04:42:19.750728Z","steps":["trace[1717244696] 'process raft request' (duration: 237.594513ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:19.75075Z","caller":"traceutil/trace.go:171","msg":"trace[1139598020] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"239.56373ms","start":"2026-06-05T04:42:19.511163Z","end":"2026-06-05T04:42:19.750727Z","steps":["trace[1139598020] 'process raft request' (duration: 114.129545ms)","trace[1139598020] 'compare' (duration: 124.893115ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:21.632118Z","caller":"traceutil/trace.go:171","msg":"trace[1311992181] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"121.233034ms","start":"2026-06-05T04:42:21.510863Z","end":"2026-06-05T04:42:21.632096Z","steps":["trace[1311992181] 'process raft request' (duration: 93.635898ms)","trace[1311992181] 'compare' (duration: 27.429613ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:21.632326Z","caller":"traceutil/trace.go:171","msg":"trace[695405942] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"119.662064ms","start":"2026-06-05T04:42:21.512651Z","end":"2026-06-05T04:42:21.632313Z","steps":["trace[695405942] 'process raft request' (duration: 119.409099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:22.203918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.153198ms","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-05T04:42:22.203998Z","caller":"traceutil/trace.go:171","msg":"trace[1562413389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1330; }","duration":"450.28094ms","start":"2026-06-05T04:42:21.753696Z","end":"2026-06-05T04:42:22.203977Z","steps":["trace[1562413389] 'range keys from in-memory index tree' (duration: 449.983345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:22.204043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:21.753676Z","time spent":"450.357552ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:42:22.204293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.136548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:42:22.204367Z","caller":"traceutil/trace.go:171","msg":"trace[1243467806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1330; }","duration":"450.224169ms","start":"2026-06-05T04:42:21.754123Z","end":"2026-06-05T04:42:22.204348Z","steps":["trace[1243467806] 'range keys from in-memory index tree' (duration: 449.997546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:22.204409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:21.754098Z","time spent":"450.302401ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:42:22.539507Z","caller":"traceutil/trace.go:171","msg":"trace[1220478775] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"131.386941ms","start":"2026-06-05T04:42:22.408096Z","end":"2026-06-05T04:42:22.539483Z","steps":["trace[1220478775] 'process raft request' (duration: 131.171907ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:29.137066Z","caller":"traceutil/trace.go:171","msg":"trace[1485194025] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"150.970882ms","start":"2026-06-05T04:42:28.98607Z","end":"2026-06-05T04:42:29.137041Z","steps":["trace[1485194025] 'process raft request' (duration: 150.813999ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:42:29.974Z","caller":"traceutil/trace.go:171","msg":"trace[1268469529] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"689.942674ms","start":"2026-06-05T04:42:29.284031Z","end":"2026-06-05T04:42:29.973974Z","steps":["trace[1268469529] 'process raft request' (duration: 689.784171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:29.974888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:29.284004Z","time spent":"690.069176ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:42:30.164627Z","caller":"traceutil/trace.go:171","msg":"trace[962457650] linearizableReadLoop","detail":"{readStateIndex:1451; appliedIndex:1449; }","duration":"502.845701ms","start":"2026-06-05T04:42:29.661748Z","end":"2026-06-05T04:42:30.164594Z","steps":["trace[962457650] 'read index received' (duration: 312.079988ms)","trace[962457650] 'applied index is now lower than readState.Index' (duration: 190.764113ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:42:30.164676Z","caller":"traceutil/trace.go:171","msg":"trace[81703131] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"506.406431ms","start":"2026-06-05T04:42:29.658241Z","end":"2026-06-05T04:42:30.164648Z","steps":["trace[81703131] 'process raft request' (duration: 498.734822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:30.16483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:29.658215Z","time spent":"506.529603ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:42:30.164931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.139827ms","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-05T04:42:30.164976Z","caller":"traceutil/trace.go:171","msg":"trace[1156231204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1395; }","duration":"503.252309ms","start":"2026-06-05T04:42:29.661712Z","end":"2026-06-05T04:42:30.164964Z","steps":["trace[1156231204] 'agreement among raft nodes before linearized reading' (duration: 503.044435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:30.165001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.641802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:42:30.165014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:29.6617Z","time spent":"503.30616ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:42:30.165037Z","caller":"traceutil/trace.go:171","msg":"trace[733687097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1395; }","duration":"137.719433ms","start":"2026-06-05T04:42:30.027307Z","end":"2026-06-05T04:42:30.165027Z","steps":["trace[733687097] 'agreement among raft nodes before linearized reading' (duration: 137.658432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:30.165115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.351627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T04:42:30.165167Z","caller":"traceutil/trace.go:171","msg":"trace[223465786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1395; }","duration":"358.450549ms","start":"2026-06-05T04:42:29.806704Z","end":"2026-06-05T04:42:30.165154Z","steps":["trace[223465786] 'agreement among raft nodes before linearized reading' (duration: 358.277295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:30.165205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:29.806682Z","time spent":"358.516389ms","remote":"127.0.0.1:33718","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-05T04:42:30.165197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.393928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T04:42:30.165282Z","caller":"traceutil/trace.go:171","msg":"trace[2046522674] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1395; }","duration":"460.51971ms","start":"2026-06-05T04:42:29.704741Z","end":"2026-06-05T04:42:30.16526Z","steps":["trace[2046522674] 'agreement among raft nodes before linearized reading' (duration: 460.227334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:42:30.165341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:42:29.704729Z","time spent":"460.602961ms","remote":"127.0.0.1:33480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"info","ts":"2026-06-05T04:46:13.249391Z","caller":"traceutil/trace.go:171","msg":"trace[1718198819] transaction","detail":"{read_only:false; response_revision:2441; number_of_response:1; }","duration":"179.732955ms","start":"2026-06-05T04:46:13.069632Z","end":"2026-06-05T04:46:13.249365Z","steps":["trace[1718198819] 'process raft request' (duration: 178.579644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:20.014727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.312352ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:46:20.01486Z","caller":"traceutil/trace.go:171","msg":"trace[961742356] linearizableReadLoop","detail":"{readStateIndex:2579; appliedIndex:2577; }","duration":"456.925723ms","start":"2026-06-05T04:46:19.557913Z","end":"2026-06-05T04:46:20.014839Z","steps":["trace[961742356] 'read index received' (duration: 4.128107ms)","trace[961742356] 'applied index is now lower than readState.Index' (duration: 452.796206ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:46:20.015224Z","caller":"traceutil/trace.go:171","msg":"trace[1701094487] transaction","detail":"{read_only:false; response_revision:2476; number_of_response:1; }","duration":"474.514313ms","start":"2026-06-05T04:46:19.540682Z","end":"2026-06-05T04:46:20.015196Z","steps":["trace[1701094487] 'process raft request' (duration: 116.630341ms)","trace[1701094487] 'compare' (duration: 357.169279ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:46:20.015361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.507841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-05T04:46:20.015441Z","caller":"traceutil/trace.go:171","msg":"trace[1551885143] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2476; }","duration":"435.601312ms","start":"2026-06-05T04:46:19.579813Z","end":"2026-06-05T04:46:20.015414Z","steps":["trace[1551885143] 'agreement among raft nodes before linearized reading' (duration: 435.463059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:20.015503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:46:19.5798Z","time spent":"435.689724ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-05T04:46:20.01539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:46:19.540669Z","time spent":"474.660306ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:46:20.015086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.167527ms","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-05T04:46:20.01522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.757661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-05T04:46:20.015705Z","caller":"traceutil/trace.go:171","msg":"trace[1940505374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2476; }","duration":"457.807ms","start":"2026-06-05T04:46:19.557882Z","end":"2026-06-05T04:46:20.015689Z","steps":["trace[1940505374] 'agreement among raft nodes before linearized reading' (duration: 457.119757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:20.015758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:46:19.557867Z","time spent":"457.879171ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:46:20.015239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.123031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T04:46:20.015781Z","caller":"traceutil/trace.go:171","msg":"trace[1997163276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2476; }","duration":"448.343653ms","start":"2026-06-05T04:46:19.567393Z","end":"2026-06-05T04:46:20.015737Z","steps":["trace[1997163276] 'agreement among raft nodes before linearized reading' (duration: 447.657819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:20.015849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:46:19.567376Z","time spent":"448.451174ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T04:46:20.015846Z","caller":"traceutil/trace.go:171","msg":"trace[635259350] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:2476; }","duration":"297.749813ms","start":"2026-06-05T04:46:19.718064Z","end":"2026-06-05T04:46:20.015814Z","steps":["trace[635259350] 'agreement among raft nodes before linearized reading' (duration: 297.07809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:20.015507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.50248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-05T04:46:20.015925Z","caller":"traceutil/trace.go:171","msg":"trace[634112976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2476; }","duration":"147.98419ms","start":"2026-06-05T04:46:19.867931Z","end":"2026-06-05T04:46:20.015915Z","steps":["trace[634112976] 'agreement among raft nodes before linearized reading' (duration: 147.311007ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:36.267542Z","caller":"traceutil/trace.go:171","msg":"trace[63111541] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"103.725978ms","start":"2026-06-05T04:46:36.163787Z","end":"2026-06-05T04:46:36.267513Z","steps":["trace[63111541] 'process raft request' (duration: 103.471804ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:42.918687Z","caller":"traceutil/trace.go:171","msg":"trace[1730419976] linearizableReadLoop","detail":"{readStateIndex:2699; appliedIndex:2698; }","duration":"120.591445ms","start":"2026-06-05T04:46:42.798074Z","end":"2026-06-05T04:46:42.918666Z","steps":["trace[1730419976] 'read index received' (duration: 120.421592ms)","trace[1730419976] 'applied index is now lower than readState.Index' (duration: 168.993µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:46:42.918711Z","caller":"traceutil/trace.go:171","msg":"trace[811513017] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"125.841384ms","start":"2026-06-05T04:46:42.792847Z","end":"2026-06-05T04:46:42.918688Z","steps":["trace[811513017] 'process raft request' (duration: 125.698431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:42.918848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.759808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" ","response":"range_response_count:1 size:1754"} {"level":"warn","ts":"2026-06-05T04:46:42.918851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.279701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-public/\" range_end:\"/registry/services/endpoints/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:46:42.918882Z","caller":"traceutil/trace.go:171","msg":"trace[1173707543] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/kube-root-ca.crt; range_end:; response_count:1; response_revision:2591; }","duration":"120.806879ms","start":"2026-06-05T04:46:42.798065Z","end":"2026-06-05T04:46:42.918872Z","steps":["trace[1173707543] 'agreement among raft nodes before linearized reading' (duration: 120.723008ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:42.9189Z","caller":"traceutil/trace.go:171","msg":"trace[974725713] range","detail":"{range_begin:/registry/services/endpoints/kube-public/; range_end:/registry/services/endpoints/kube-public0; response_count:0; response_revision:2591; }","duration":"102.340902ms","start":"2026-06-05T04:46:42.816546Z","end":"2026-06-05T04:46:42.918887Z","steps":["trace[974725713] 'agreement among raft nodes before linearized reading' (duration: 102.250071ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:43.431022Z","caller":"traceutil/trace.go:171","msg":"trace[1821099321] linearizableReadLoop","detail":"{readStateIndex:2701; appliedIndex:2700; }","duration":"106.502271ms","start":"2026-06-05T04:46:43.324495Z","end":"2026-06-05T04:46:43.430997Z","steps":["trace[1821099321] 'read index received' (duration: 106.264926ms)","trace[1821099321] 'applied index is now lower than readState.Index' (duration: 236.175µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:46:43.43264Z","caller":"traceutil/trace.go:171","msg":"trace[2055143137] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"133.288023ms","start":"2026-06-05T04:46:43.299312Z","end":"2026-06-05T04:46:43.4326Z","steps":["trace[2055143137] 'process raft request' (duration: 131.531271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:43.432816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.019693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-node-lease/\" range_end:\"/registry/services/specs/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:46:43.432939Z","caller":"traceutil/trace.go:171","msg":"trace[465108008] range","detail":"{range_begin:/registry/services/specs/kube-node-lease/; range_end:/registry/services/specs/kube-node-lease0; response_count:0; response_revision:2593; }","duration":"105.164116ms","start":"2026-06-05T04:46:43.32773Z","end":"2026-06-05T04:46:43.432894Z","steps":["trace[465108008] 'agreement among raft nodes before linearized reading' (duration: 104.964462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:43.437624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.167596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4452"} {"level":"info","ts":"2026-06-05T04:46:43.437673Z","caller":"traceutil/trace.go:171","msg":"trace[488846279] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:2593; }","duration":"113.233678ms","start":"2026-06-05T04:46:43.324417Z","end":"2026-06-05T04:46:43.437651Z","steps":["trace[488846279] 'agreement among raft nodes before linearized reading' (duration: 109.058569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:43.437986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.855322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" ","response":"range_response_count:1 size:1036305"} {"level":"info","ts":"2026-06-05T04:46:43.438042Z","caller":"traceutil/trace.go:171","msg":"trace[101102612] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; range_end:; response_count:1; response_revision:2593; }","duration":"102.964673ms","start":"2026-06-05T04:46:43.335056Z","end":"2026-06-05T04:46:43.438021Z","steps":["trace[101102612] 'agreement among raft nodes before linearized reading' (duration: 97.861588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:44.491297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.490542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"} {"level":"info","ts":"2026-06-05T04:46:44.491381Z","caller":"traceutil/trace.go:171","msg":"trace[571098129] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:2599; }","duration":"129.608904ms","start":"2026-06-05T04:46:44.361755Z","end":"2026-06-05T04:46:44.491364Z","steps":["trace[571098129] 'range keys from in-memory index tree' (duration: 129.265358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:44.491614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.190285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-06-05T04:46:44.491693Z","caller":"traceutil/trace.go:171","msg":"trace[2001098800] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:2599; }","duration":"155.655864ms","start":"2026-06-05T04:46:44.336024Z","end":"2026-06-05T04:46:44.49168Z","steps":["trace[2001098800] 'range keys from in-memory index tree' (duration: 154.873689ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:46.1294Z","caller":"traceutil/trace.go:171","msg":"trace[2004427861] linearizableReadLoop","detail":"{readStateIndex:2713; appliedIndex:2712; }","duration":"284.554645ms","start":"2026-06-05T04:46:45.844818Z","end":"2026-06-05T04:46:46.129372Z","steps":["trace[2004427861] 'read index received' (duration: 284.447293ms)","trace[2004427861] 'applied index is now lower than readState.Index' (duration: 105.852µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:46:46.129437Z","caller":"traceutil/trace.go:171","msg":"trace[1582358599] transaction","detail":"{read_only:false; response_revision:2604; number_of_response:1; }","duration":"294.746887ms","start":"2026-06-05T04:46:45.834662Z","end":"2026-06-05T04:46:46.129409Z","steps":["trace[1582358599] 'process raft request' (duration: 294.549183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:46.129616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.76794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-06-05T04:46:46.1297Z","caller":"traceutil/trace.go:171","msg":"trace[885415910] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2604; }","duration":"284.896473ms","start":"2026-06-05T04:46:45.844785Z","end":"2026-06-05T04:46:46.129682Z","steps":["trace[885415910] 'agreement among raft nodes before linearized reading' (duration: 284.717049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:46.129764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.820367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:46:46.129817Z","caller":"traceutil/trace.go:171","msg":"trace[1893293620] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2604; }","duration":"214.912788ms","start":"2026-06-05T04:46:45.914888Z","end":"2026-06-05T04:46:46.129801Z","steps":["trace[1893293620] 'agreement among raft nodes before linearized reading' (duration: 214.829936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:46.129831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.77873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:46:46.129869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.007948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:11246"} {"level":"info","ts":"2026-06-05T04:46:46.13004Z","caller":"traceutil/trace.go:171","msg":"trace[2037759089] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:2604; }","duration":"241.221671ms","start":"2026-06-05T04:46:45.888804Z","end":"2026-06-05T04:46:46.130026Z","steps":["trace[2037759089] 'agreement among raft nodes before linearized reading' (duration: 240.743741ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:46.129927Z","caller":"traceutil/trace.go:171","msg":"trace[1385754552] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2604; }","duration":"112.926612ms","start":"2026-06-05T04:46:46.016977Z","end":"2026-06-05T04:46:46.129903Z","steps":["trace[1385754552] 'agreement among raft nodes before linearized reading' (duration: 112.737298ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:50.434441Z","caller":"traceutil/trace.go:171","msg":"trace[1298029466] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"108.161363ms","start":"2026-06-05T04:46:50.326237Z","end":"2026-06-05T04:46:50.434398Z","steps":["trace[1298029466] 'process raft request' (duration: 92.890466ms)","trace[1298029466] 'compare' (duration: 15.098704ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:46:54.433355Z","caller":"traceutil/trace.go:171","msg":"trace[841360314] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"102.959303ms","start":"2026-06-05T04:46:54.330366Z","end":"2026-06-05T04:46:54.433325Z","steps":["trace[841360314] 'process raft request' (duration: 102.75438ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:56.71464Z","caller":"traceutil/trace.go:171","msg":"trace[1737605706] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"138.545843ms","start":"2026-06-05T04:46:56.576056Z","end":"2026-06-05T04:46:56.714601Z","steps":["trace[1737605706] 'process raft request' (duration: 138.41843ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:56.759714Z","caller":"traceutil/trace.go:171","msg":"trace[712265609] linearizableReadLoop","detail":"{readStateIndex:2764; appliedIndex:2762; }","duration":"169.75346ms","start":"2026-06-05T04:46:56.589935Z","end":"2026-06-05T04:46:56.759689Z","steps":["trace[712265609] 'read index received' (duration: 124.463758ms)","trace[712265609] 'applied index is now lower than readState.Index' (duration: 45.288542ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:46:56.7599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.70175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:46:56.759938Z","caller":"traceutil/trace.go:171","msg":"trace[1888443237] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2653; }","duration":"159.799811ms","start":"2026-06-05T04:46:56.600128Z","end":"2026-06-05T04:46:56.759928Z","steps":["trace[1888443237] 'agreement among raft nodes before linearized reading' (duration: 159.698899ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:46:56.759902Z","caller":"traceutil/trace.go:171","msg":"trace[1068489696] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"182.658332ms","start":"2026-06-05T04:46:56.577188Z","end":"2026-06-05T04:46:56.759846Z","steps":["trace[1068489696] 'process raft request' (duration: 182.338396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:46:56.760182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.215198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-05T04:46:56.760263Z","caller":"traceutil/trace.go:171","msg":"trace[1907220312] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2653; }","duration":"170.34536ms","start":"2026-06-05T04:46:56.589898Z","end":"2026-06-05T04:46:56.760243Z","steps":["trace[1907220312] 'agreement among raft nodes before linearized reading' (duration: 170.037724ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:47:03.078117Z","caller":"traceutil/trace.go:171","msg":"trace[549430325] linearizableReadLoop","detail":"{readStateIndex:2792; appliedIndex:2791; }","duration":"154.504755ms","start":"2026-06-05T04:47:02.923576Z","end":"2026-06-05T04:47:03.078081Z","steps":["trace[549430325] 'read index received' (duration: 113.241048ms)","trace[549430325] 'applied index is now lower than readState.Index' (duration: 41.262397ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:47:03.078253Z","caller":"traceutil/trace.go:171","msg":"trace[398585296] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"162.665625ms","start":"2026-06-05T04:47:02.915574Z","end":"2026-06-05T04:47:03.078239Z","steps":["trace[398585296] 'process raft request' (duration: 121.316616ms)","trace[398585296] 'compare' (duration: 40.942221ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:47:03.078371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.245612ms","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-05T04:47:03.078448Z","caller":"traceutil/trace.go:171","msg":"trace[1789657157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2680; }","duration":"129.363004ms","start":"2026-06-05T04:47:02.949066Z","end":"2026-06-05T04:47:03.078429Z","steps":["trace[1789657157] 'agreement among raft nodes before linearized reading' (duration: 129.210801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:47:03.078615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.032195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-njtmw\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-06-05T04:47:03.078651Z","caller":"traceutil/trace.go:171","msg":"trace[1266252550] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-njtmw; range_end:; response_count:1; response_revision:2680; }","duration":"155.064505ms","start":"2026-06-05T04:47:02.923574Z","end":"2026-06-05T04:47:03.078638Z","steps":["trace[1266252550] 'agreement among raft nodes before linearized reading' (duration: 154.968394ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:47:03.343188Z","caller":"traceutil/trace.go:171","msg":"trace[790896526] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2793; }","duration":"224.463598ms","start":"2026-06-05T04:47:03.118703Z","end":"2026-06-05T04:47:03.343167Z","steps":["trace[790896526] 'read index received' (duration: 152.404096ms)","trace[790896526] 'applied index is now lower than readState.Index' (duration: 72.058282ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:47:03.343306Z","caller":"traceutil/trace.go:171","msg":"trace[28107096] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"237.20178ms","start":"2026-06-05T04:47:03.106091Z","end":"2026-06-05T04:47:03.343293Z","steps":["trace[28107096] 'process raft request' (duration: 165.004826ms)","trace[28107096] 'compare' (duration: 71.972971ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:47:03.343553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.430308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-06-05T04:47:03.343656Z","caller":"traceutil/trace.go:171","msg":"trace[236962360] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2682; }","duration":"181.56708ms","start":"2026-06-05T04:47:03.162062Z","end":"2026-06-05T04:47:03.343629Z","steps":["trace[236962360] 'agreement among raft nodes before linearized reading' (duration: 181.327206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:47:03.343656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.933286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6951"} {"level":"info","ts":"2026-06-05T04:47:03.343731Z","caller":"traceutil/trace.go:171","msg":"trace[668590274] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2682; }","duration":"225.053128ms","start":"2026-06-05T04:47:03.118658Z","end":"2026-06-05T04:47:03.343711Z","steps":["trace[668590274] 'agreement among raft nodes before linearized reading' (duration: 224.813274ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:47:03.577212Z","caller":"traceutil/trace.go:171","msg":"trace[69036368] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"128.024439ms","start":"2026-06-05T04:47:03.449158Z","end":"2026-06-05T04:47:03.577182Z","steps":["trace[69036368] 'process raft request' (duration: 54.961669ms)","trace[69036368] 'compare' (duration: 72.780155ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:47:03.800624Z","caller":"traceutil/trace.go:171","msg":"trace[1494360253] linearizableReadLoop","detail":"{readStateIndex:2797; appliedIndex:2796; }","duration":"146.958675ms","start":"2026-06-05T04:47:03.653643Z","end":"2026-06-05T04:47:03.800602Z","steps":["trace[1494360253] 'read index received' (duration: 94.014464ms)","trace[1494360253] 'applied index is now lower than readState.Index' (duration: 52.943231ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:47:03.800669Z","caller":"traceutil/trace.go:171","msg":"trace[1115296008] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"157.712223ms","start":"2026-06-05T04:47:03.642915Z","end":"2026-06-05T04:47:03.800627Z","steps":["trace[1115296008] 'process raft request' (duration: 104.709551ms)","trace[1115296008] 'compare' (duration: 52.742407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:47:03.800757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.101339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5164"} {"level":"info","ts":"2026-06-05T04:47:03.800811Z","caller":"traceutil/trace.go:171","msg":"trace[328899875] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:2685; }","duration":"147.196031ms","start":"2026-06-05T04:47:03.653605Z","end":"2026-06-05T04:47:03.800801Z","steps":["trace[328899875] 'agreement among raft nodes before linearized reading' (duration: 147.083089ms)"],"step_count":1}