{"level":"warn","ts":"2026-06-16T10:23:31.973905Z","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-16T10:23:31.973981Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.107:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.107:2380","--initial-cluster=instance=https://199.19.213.107:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.107:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.107: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-16T10:23:31.974034Z","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-16T10:23:31.974048Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.107:2380"]} {"level":"info","ts":"2026-06-16T10:23:31.974064Z","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-16T10:23:31.974671Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.107:2379"]} {"level":"info","ts":"2026-06-16T10:23:31.974736Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.107:2380"],"listen-peer-urls":["https://199.19.213.107:2380"],"advertise-client-urls":["https://199.19.213.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.107: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-16T10:23:31.981225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.312749ms"} {"level":"info","ts":"2026-06-16T10:23:31.990006Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be75c9626aba3f77","cluster-id":"c32d1248c0d0c6d"} {"level":"info","ts":"2026-06-16T10:23:31.990086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T10:23:31.990105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 became follower at term 0"} {"level":"info","ts":"2026-06-16T10:23:31.990113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be75c9626aba3f77 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T10:23:31.990121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 became follower at term 1"} {"level":"info","ts":"2026-06-16T10:23:31.990155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 switched to configuration voters=(13724096864016023415)"} {"level":"warn","ts":"2026-06-16T10:23:32.00168Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T10:23:32.003438Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T10:23:32.005342Z","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-16T10:23:32.007788Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be75c9626aba3f77","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T10:23:32.008832Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be75c9626aba3f77","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T10:23:32.008958Z","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-16T10:23:32.008992Z","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-16T10:23:32.009002Z","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-16T10:23:32.011161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 switched to configuration voters=(13724096864016023415)"} {"level":"info","ts":"2026-06-16T10:23:32.011843Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c32d1248c0d0c6d","local-member-id":"be75c9626aba3f77","added-peer-id":"be75c9626aba3f77","added-peer-peer-urls":["https://199.19.213.107:2380"]} {"level":"info","ts":"2026-06-16T10:23:32.013928Z","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-16T10:23:32.014036Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.107:2380"} {"level":"info","ts":"2026-06-16T10:23:32.014103Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.107:2380"} {"level":"info","ts":"2026-06-16T10:23:32.015397Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be75c9626aba3f77","initial-advertise-peer-urls":["https://199.19.213.107:2380"],"listen-peer-urls":["https://199.19.213.107:2380"],"advertise-client-urls":["https://199.19.213.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T10:23:32.015501Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T10:23:32.792373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T10:23:32.792447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T10:23:32.792469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 received MsgPreVoteResp from be75c9626aba3f77 at term 1"} {"level":"info","ts":"2026-06-16T10:23:32.792495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 became candidate at term 2"} {"level":"info","ts":"2026-06-16T10:23:32.792509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 received MsgVoteResp from be75c9626aba3f77 at term 2"} {"level":"info","ts":"2026-06-16T10:23:32.79252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be75c9626aba3f77 became leader at term 2"} {"level":"info","ts":"2026-06-16T10:23:32.792535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be75c9626aba3f77 elected leader be75c9626aba3f77 at term 2"} {"level":"info","ts":"2026-06-16T10:23:32.793518Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be75c9626aba3f77","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.107:2379]}","request-path":"/0/members/be75c9626aba3f77/attributes","cluster-id":"c32d1248c0d0c6d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T10:23:32.793632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T10:23:32.793685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T10:23:32.793951Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:23:32.795328Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c32d1248c0d0c6d","local-member-id":"be75c9626aba3f77","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:23:32.79556Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:23:32.795615Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T10:23:32.797242Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T10:23:32.797518Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.107:2379"} {"level":"info","ts":"2026-06-16T10:23:32.799441Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T10:23:32.799501Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T10:23:42.279698Z","caller":"traceutil/trace.go:171","msg":"trace[351642551] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:308; }","duration":"136.841574ms","start":"2026-06-16T10:23:42.142829Z","end":"2026-06-16T10:23:42.27967Z","steps":["trace[351642551] 'read index received' (duration: 41.365904ms)","trace[351642551] 'applied index is now lower than readState.Index' (duration: 95.47472ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:42.279792Z","caller":"traceutil/trace.go:171","msg":"trace[1599840959] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"140.398234ms","start":"2026-06-16T10:23:42.13935Z","end":"2026-06-16T10:23:42.279748Z","steps":["trace[1599840959] 'process raft request' (duration: 128.622402ms)","trace[1599840959] 'compare' (duration: 11.56749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:42.279883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.035956ms","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-16T10:23:42.279965Z","caller":"traceutil/trace.go:171","msg":"trace[130980297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:295; }","duration":"137.160957ms","start":"2026-06-16T10:23:42.142791Z","end":"2026-06-16T10:23:42.279952Z","steps":["trace[130980297] 'agreement among raft nodes before linearized reading' (duration: 136.998056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.573673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.466681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:43.573813Z","caller":"traceutil/trace.go:171","msg":"trace[630375751] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:314; }","duration":"1.033832076s","start":"2026-06-16T10:23:42.539949Z","end":"2026-06-16T10:23:43.573781Z","steps":["trace[630375751] 'read index received' (duration: 14.519133ms)","trace[630375751] 'applied index is now lower than readState.Index' (duration: 1.019311243s)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:43.573944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034007088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-16T10:23:43.573987Z","caller":"traceutil/trace.go:171","msg":"trace[1616982497] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:301; }","duration":"1.034092228s","start":"2026-06-16T10:23:42.539881Z","end":"2026-06-16T10:23:43.573973Z","steps":["trace[1616982497] 'agreement among raft nodes before linearized reading' (duration: 1.034005237s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.574029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.539843Z","time spent":"1.03417758s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.574116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.762265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-06-16T10:23:43.574225Z","caller":"traceutil/trace.go:171","msg":"trace[172208863] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:301; }","duration":"984.970597ms","start":"2026-06-16T10:23:42.589237Z","end":"2026-06-16T10:23:43.574208Z","steps":["trace[172208863] 'agreement among raft nodes before linearized reading' (duration: 984.699694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.574352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.58922Z","time spent":"985.072978ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.574385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.347867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-16T10:23:43.574431Z","caller":"traceutil/trace.go:171","msg":"trace[521266580] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:301; }","duration":"783.433548ms","start":"2026-06-16T10:23:42.790987Z","end":"2026-06-16T10:23:43.57442Z","steps":["trace[521266580] 'agreement among raft nodes before linearized reading' (duration: 783.362907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.574483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.790955Z","time spent":"783.520129ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.57464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.215557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-16T10:23:43.574676Z","caller":"traceutil/trace.go:171","msg":"trace[438619217] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:301; }","duration":"634.307218ms","start":"2026-06-16T10:23:42.94036Z","end":"2026-06-16T10:23:43.574667Z","steps":["trace[438619217] 'agreement among raft nodes before linearized reading' (duration: 634.247367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.574711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.940315Z","time spent":"634.388719ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.574855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.833864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-16T10:23:43.574889Z","caller":"traceutil/trace.go:171","msg":"trace[905601872] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:301; }","duration":"684.926175ms","start":"2026-06-16T10:23:42.889955Z","end":"2026-06-16T10:23:43.574881Z","steps":["trace[905601872] 'agreement among raft nodes before linearized reading' (duration: 684.869744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.574923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.889932Z","time spent":"684.984416ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-06-16T10:23:43.57385Z","caller":"traceutil/trace.go:171","msg":"trace[323388195] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"1.037993981s","start":"2026-06-16T10:23:42.535813Z","end":"2026-06-16T10:23:43.573807Z","steps":["trace[323388195] 'process raft request' (duration: 261.718283ms)","trace[323388195] 'compare' (duration: 775.168956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:43.575091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.32537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-16T10:23:43.575133Z","caller":"traceutil/trace.go:171","msg":"trace[1907131763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:301; }","duration":"735.4036ms","start":"2026-06-16T10:23:42.83972Z","end":"2026-06-16T10:23:43.575124Z","steps":["trace[1907131763] 'agreement among raft nodes before linearized reading' (duration: 735.34067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.575168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.839699Z","time spent":"735.459461ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.575097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.263649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-16T10:23:43.57549Z","caller":"traceutil/trace.go:171","msg":"trace[1546471993] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:301; }","duration":"834.699663ms","start":"2026-06-16T10:23:42.740773Z","end":"2026-06-16T10:23:43.575472Z","steps":["trace[1546471993] 'agreement among raft nodes before linearized reading' (duration: 834.163477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.575542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.740737Z","time spent":"834.791105ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.575794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.298591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-16T10:23:43.575867Z","caller":"traceutil/trace.go:171","msg":"trace[223139401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:301; }","duration":"935.423872ms","start":"2026-06-16T10:23:42.640427Z","end":"2026-06-16T10:23:43.575851Z","steps":["trace[223139401] 'agreement among raft nodes before linearized reading' (duration: 935.308131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.576044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.640399Z","time spent":"935.632304ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-06-16T10:23:43.576224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.002568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-16T10:23:43.576334Z","caller":"traceutil/trace.go:171","msg":"trace[2038637898] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:301; }","duration":"886.24687ms","start":"2026-06-16T10:23:42.690063Z","end":"2026-06-16T10:23:43.576309Z","steps":["trace[2038637898] 'agreement among raft nodes before linearized reading' (duration: 885.055917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:43.5765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.690032Z","time spent":"886.447143ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-06-16T10:23:43.576594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:42.535792Z","time spent":"1.039251557s","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:44.689023Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4573298562626787821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T10:23:44.758034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.992564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:44.758101Z","caller":"traceutil/trace.go:171","msg":"trace[1366527789] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"1.171764886s","start":"2026-06-16T10:23:43.586321Z","end":"2026-06-16T10:23:44.758085Z","steps":["trace[1366527789] 'process raft request' (duration: 443.676581ms)","trace[1366527789] 'compare' (duration: 727.417708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:44.758967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.586308Z","time spent":"1.171818586s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T10:23:45.153175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.176839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:45.153508Z","caller":"traceutil/trace.go:171","msg":"trace[235493660] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"1.563948271s","start":"2026-06-16T10:23:43.589479Z","end":"2026-06-16T10:23:45.153428Z","steps":["trace[235493660] 'process raft request' (duration: 1.56384509s)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.153566Z","caller":"traceutil/trace.go:171","msg":"trace[731597552] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"1.56279957s","start":"2026-06-16T10:23:43.590739Z","end":"2026-06-16T10:23:45.153538Z","steps":["trace[731597552] 'process raft request' (duration: 1.562613788s)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.153451Z","caller":"traceutil/trace.go:171","msg":"trace[829265443] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"1.565066274s","start":"2026-06-16T10:23:43.588336Z","end":"2026-06-16T10:23:45.153402Z","steps":["trace[829265443] 'process raft request' (duration: 1.564939303s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.153661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.58946Z","time spent":"1.564135023s","remote":"127.0.0.1:40504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T10:23:45.15366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.590731Z","time spent":"1.56288244s","remote":"127.0.0.1:40254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:45.153675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.588325Z","time spent":"1.565310467s","remote":"127.0.0.1:40114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.153756Z","caller":"traceutil/trace.go:171","msg":"trace[1979361415] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"1.56288205s","start":"2026-06-16T10:23:43.590862Z","end":"2026-06-16T10:23:45.153744Z","steps":["trace[1979361415] 'process raft request' (duration: 1.562551556s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.153835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.590857Z","time spent":"1.56293784s","remote":"127.0.0.1:40192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:45.154106Z","caller":"traceutil/trace.go:171","msg":"trace[1344738043] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"1.563162223s","start":"2026-06-16T10:23:43.590906Z","end":"2026-06-16T10:23:45.154068Z","steps":["trace[1344738043] 'process raft request' (duration: 1.562771909s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.154253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.590884Z","time spent":"1.563307915s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.15431Z","caller":"traceutil/trace.go:171","msg":"trace[1966102471] linearizableReadLoop","detail":"{readStateIndex:330; appliedIndex:317; }","duration":"966.005154ms","start":"2026-06-16T10:23:44.18829Z","end":"2026-06-16T10:23:45.154295Z","steps":["trace[1966102471] 'read index received' (duration: 844.726903ms)","trace[1966102471] 'applied index is now lower than readState.Index' (duration: 121.277541ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:45.154481Z","caller":"traceutil/trace.go:171","msg":"trace[2092286250] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"1.563153642s","start":"2026-06-16T10:23:43.591309Z","end":"2026-06-16T10:23:45.154463Z","steps":["trace[2092286250] 'process raft request' (duration: 1.562764188s)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.154556Z","caller":"traceutil/trace.go:171","msg":"trace[106773646] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"806.539821ms","start":"2026-06-16T10:23:44.348002Z","end":"2026-06-16T10:23:45.154542Z","steps":["trace[106773646] 'process raft request' (duration: 806.232457ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.15456Z","caller":"traceutil/trace.go:171","msg":"trace[650633063] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"1.5628993s","start":"2026-06-16T10:23:43.591649Z","end":"2026-06-16T10:23:45.154548Z","steps":["trace[650633063] 'process raft request' (duration: 1.562493965s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.154566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.591294Z","time spent":"1.563229245s","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:45.154624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.347971Z","time spent":"806.611933ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:45.154741Z","caller":"traceutil/trace.go:171","msg":"trace[1403561827] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"1.56377812s","start":"2026-06-16T10:23:43.590952Z","end":"2026-06-16T10:23:45.15473Z","steps":["trace[1403561827] 'process raft request' (duration: 1.563007531s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.154786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.590884Z","time spent":"1.563880182s","remote":"127.0.0.1:40184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.154892Z","caller":"traceutil/trace.go:171","msg":"trace[1205404656] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"391.6128ms","start":"2026-06-16T10:23:44.763269Z","end":"2026-06-16T10:23:45.154881Z","steps":["trace[1205404656] 'process raft request' (duration: 390.999222ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.154483Z","caller":"traceutil/trace.go:171","msg":"trace[378690052] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"1.561927549s","start":"2026-06-16T10:23:43.592487Z","end":"2026-06-16T10:23:45.154414Z","steps":["trace[378690052] 'process raft request' (duration: 1.561718967s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.154631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.591617Z","time spent":"1.562973261s","remote":"127.0.0.1:40334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:45.154946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.763243Z","time spent":"391.67776ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.155014Z","caller":"traceutil/trace.go:171","msg":"trace[2008066420] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"1.56373357s","start":"2026-06-16T10:23:43.59127Z","end":"2026-06-16T10:23:45.155003Z","steps":["trace[2008066420] 'process raft request' (duration: 1.562742399s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.155072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.591264Z","time spent":"1.563776011s","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:45.155098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.818923ms","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-16T10:23:45.15513Z","caller":"traceutil/trace.go:171","msg":"trace[77870947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:316; }","duration":"966.907554ms","start":"2026-06-16T10:23:44.188213Z","end":"2026-06-16T10:23:45.155121Z","steps":["trace[77870947] 'agreement among raft nodes before linearized reading' (duration: 966.843754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.155163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.188177Z","time spent":"966.978665ms","remote":"127.0.0.1:40256","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-16T10:23:45.155342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.8431ms","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-16T10:23:45.155373Z","caller":"traceutil/trace.go:171","msg":"trace[2142921302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:316; }","duration":"841.907981ms","start":"2026-06-16T10:23:44.313456Z","end":"2026-06-16T10:23:45.155364Z","steps":["trace[2142921302] 'agreement among raft nodes before linearized reading' (duration: 841.85286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.155399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.313437Z","time spent":"841.955281ms","remote":"127.0.0.1:40256","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-16T10:23:45.155029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.592481Z","time spent":"1.562466116s","remote":"127.0.0.1:40334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:45.154567Z","caller":"traceutil/trace.go:171","msg":"trace[1890272026] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"1.567169737s","start":"2026-06-16T10:23:43.586511Z","end":"2026-06-16T10:23:45.153681Z","steps":["trace[1890272026] 'process raft request' (duration: 1.446420812s)","trace[1890272026] 'compare' (duration: 120.010277ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:45.155552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.143784ms","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-16T10:23:45.155873Z","caller":"traceutil/trace.go:171","msg":"trace[1183359687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:316; }","duration":"662.493898ms","start":"2026-06-16T10:23:44.493364Z","end":"2026-06-16T10:23:45.155858Z","steps":["trace[1183359687] 'agreement among raft nodes before linearized reading' (duration: 662.158185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.155926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.493344Z","time spent":"662.560359ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T10:23:45.15553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.325318ms","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-16T10:23:45.156456Z","caller":"traceutil/trace.go:171","msg":"trace[1947021887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:316; }","duration":"626.296839ms","start":"2026-06-16T10:23:44.53015Z","end":"2026-06-16T10:23:45.156447Z","steps":["trace[1947021887] 'agreement among raft nodes before linearized reading' (duration: 625.318839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.156486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:44.530118Z","time spent":"626.35924ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T10:23:45.155597Z","caller":"traceutil/trace.go:171","msg":"trace[1608122749] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"1.563131662s","start":"2026-06-16T10:23:43.592452Z","end":"2026-06-16T10:23:45.155584Z","steps":["trace[1608122749] 'process raft request' (duration: 1.561728786s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.156816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.592446Z","time spent":"1.564332855s","remote":"127.0.0.1:40334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:45.162266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:43.586495Z","time spent":"1.572557906s","remote":"127.0.0.1:40496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T10:23:45.411021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.05242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:45.411273Z","caller":"traceutil/trace.go:171","msg":"trace[1540266325] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"249.850531ms","start":"2026-06-16T10:23:45.161384Z","end":"2026-06-16T10:23:45.411234Z","steps":["trace[1540266325] 'process raft request' (duration: 148.526158ms)","trace[1540266325] 'compare' (duration: 100.897838ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:45.411368Z","caller":"traceutil/trace.go:171","msg":"trace[536345580] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"249.439247ms","start":"2026-06-16T10:23:45.161887Z","end":"2026-06-16T10:23:45.411326Z","steps":["trace[536345580] 'process raft request' (duration: 249.276915ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.411472Z","caller":"traceutil/trace.go:171","msg":"trace[2000902997] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"249.639339ms","start":"2026-06-16T10:23:45.161797Z","end":"2026-06-16T10:23:45.411436Z","steps":["trace[2000902997] 'process raft request' (duration: 249.313326ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.411724Z","caller":"traceutil/trace.go:171","msg":"trace[456946804] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"249.607189ms","start":"2026-06-16T10:23:45.16209Z","end":"2026-06-16T10:23:45.411697Z","steps":["trace[456946804] 'process raft request' (duration: 249.111204ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412044Z","caller":"traceutil/trace.go:171","msg":"trace[1168005869] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"246.260111ms","start":"2026-06-16T10:23:45.16577Z","end":"2026-06-16T10:23:45.41203Z","steps":["trace[1168005869] 'process raft request' (duration: 246.191361ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412076Z","caller":"traceutil/trace.go:171","msg":"trace[2144002227] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"246.684747ms","start":"2026-06-16T10:23:45.165371Z","end":"2026-06-16T10:23:45.412056Z","steps":["trace[2144002227] 'process raft request' (duration: 246.559365ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412089Z","caller":"traceutil/trace.go:171","msg":"trace[1926355820] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"246.764418ms","start":"2026-06-16T10:23:45.165306Z","end":"2026-06-16T10:23:45.41207Z","steps":["trace[1926355820] 'process raft request' (duration: 246.573086ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412122Z","caller":"traceutil/trace.go:171","msg":"trace[610779438] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"249.391536ms","start":"2026-06-16T10:23:45.162701Z","end":"2026-06-16T10:23:45.412093Z","steps":["trace[610779438] 'process raft request' (duration: 249.122433ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412074Z","caller":"traceutil/trace.go:171","msg":"trace[601634289] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"249.908182ms","start":"2026-06-16T10:23:45.162152Z","end":"2026-06-16T10:23:45.412061Z","steps":["trace[601634289] 'process raft request' (duration: 249.372566ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412507Z","caller":"traceutil/trace.go:171","msg":"trace[906290123] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"246.314452ms","start":"2026-06-16T10:23:45.166177Z","end":"2026-06-16T10:23:45.412491Z","steps":["trace[906290123] 'process raft request' (duration: 245.822176ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412793Z","caller":"traceutil/trace.go:171","msg":"trace[1455932139] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"243.707534ms","start":"2026-06-16T10:23:45.169071Z","end":"2026-06-16T10:23:45.412778Z","steps":["trace[1455932139] 'process raft request' (duration: 243.366081ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412854Z","caller":"traceutil/trace.go:171","msg":"trace[532615242] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"242.574662ms","start":"2026-06-16T10:23:45.170268Z","end":"2026-06-16T10:23:45.412843Z","steps":["trace[532615242] 'process raft request' (duration: 242.452781ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.412881Z","caller":"traceutil/trace.go:171","msg":"trace[1819438754] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:332; }","duration":"250.943403ms","start":"2026-06-16T10:23:45.161928Z","end":"2026-06-16T10:23:45.412871Z","steps":["trace[1819438754] 'read index received' (duration: 16.994325ms)","trace[1819438754] 'applied index is now lower than readState.Index' (duration: 233.948238ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:45.412842Z","caller":"traceutil/trace.go:171","msg":"trace[1107738816] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"230.635823ms","start":"2026-06-16T10:23:45.182193Z","end":"2026-06-16T10:23:45.412829Z","steps":["trace[1107738816] 'process raft request' (duration: 230.591062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.413164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.123865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-16T10:23:45.413988Z","caller":"traceutil/trace.go:171","msg":"trace[634631564] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:330; }","duration":"252.063695ms","start":"2026-06-16T10:23:45.161908Z","end":"2026-06-16T10:23:45.413971Z","steps":["trace[634631564] 'agreement among raft nodes before linearized reading' (duration: 251.111345ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.695381Z","caller":"traceutil/trace.go:171","msg":"trace[699957884] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"272.399638ms","start":"2026-06-16T10:23:45.422955Z","end":"2026-06-16T10:23:45.695354Z","steps":["trace[699957884] 'process raft request' (duration: 272.209716ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.695536Z","caller":"traceutil/trace.go:171","msg":"trace[1816841998] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"273.613161ms","start":"2026-06-16T10:23:45.421892Z","end":"2026-06-16T10:23:45.695505Z","steps":["trace[1816841998] 'process raft request' (duration: 209.29036ms)","trace[1816841998] 'compare' (duration: 63.762094ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:45.695662Z","caller":"traceutil/trace.go:171","msg":"trace[1924472148] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"272.426718ms","start":"2026-06-16T10:23:45.423225Z","end":"2026-06-16T10:23:45.695651Z","steps":["trace[1924472148] 'process raft request' (duration: 272.042304ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.695756Z","caller":"traceutil/trace.go:171","msg":"trace[1586105848] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"273.820252ms","start":"2026-06-16T10:23:45.421926Z","end":"2026-06-16T10:23:45.695746Z","steps":["trace[1586105848] 'process raft request' (duration: 273.189504ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.69592Z","caller":"traceutil/trace.go:171","msg":"trace[548948382] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:346; }","duration":"239.778152ms","start":"2026-06-16T10:23:45.456132Z","end":"2026-06-16T10:23:45.69591Z","steps":["trace[548948382] 'read index received' (duration: 175.244609ms)","trace[548948382] 'applied index is now lower than readState.Index' (duration: 64.532763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:45.696132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.055345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"warn","ts":"2026-06-16T10:23:45.696174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.843682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-06-16T10:23:45.696184Z","caller":"traceutil/trace.go:171","msg":"trace[257510816] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:336; }","duration":"273.126906ms","start":"2026-06-16T10:23:45.423043Z","end":"2026-06-16T10:23:45.69617Z","steps":["trace[257510816] 'agreement among raft nodes before linearized reading' (duration: 273.008634ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.696242Z","caller":"traceutil/trace.go:171","msg":"trace[136686442] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:336; }","duration":"273.916864ms","start":"2026-06-16T10:23:45.422284Z","end":"2026-06-16T10:23:45.696201Z","steps":["trace[136686442] 'agreement among raft nodes before linearized reading' (duration: 273.784983ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.696231Z","caller":"traceutil/trace.go:171","msg":"trace[639151785] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"272.635259ms","start":"2026-06-16T10:23:45.423561Z","end":"2026-06-16T10:23:45.696196Z","steps":["trace[639151785] 'process raft request' (duration: 271.743279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.989853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.241044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:45.990214Z","caller":"traceutil/trace.go:171","msg":"trace[569743815] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"528.521787ms","start":"2026-06-16T10:23:45.461661Z","end":"2026-06-16T10:23:45.990183Z","steps":["trace[569743815] 'process raft request' (duration: 335.875619ms)","trace[569743815] 'compare' (duration: 192.091672ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:45.990285Z","caller":"traceutil/trace.go:171","msg":"trace[1215966204] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"285.330638ms","start":"2026-06-16T10:23:45.704936Z","end":"2026-06-16T10:23:45.990266Z","steps":["trace[1215966204] 'process raft request' (duration: 285.242917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.990344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:45.461637Z","time spent":"528.662798ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.990535Z","caller":"traceutil/trace.go:171","msg":"trace[1900721428] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"526.337533ms","start":"2026-06-16T10:23:45.464184Z","end":"2026-06-16T10:23:45.990521Z","steps":["trace[1900721428] 'process raft request' (duration: 525.770837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.990591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:45.464164Z","time spent":"526.397553ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:45.990638Z","caller":"traceutil/trace.go:171","msg":"trace[723352018] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"289.898308ms","start":"2026-06-16T10:23:45.700716Z","end":"2026-06-16T10:23:45.990614Z","steps":["trace[723352018] 'process raft request' (duration: 289.304301ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.991053Z","caller":"traceutil/trace.go:171","msg":"trace[1129546491] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:351; }","duration":"295.092734ms","start":"2026-06-16T10:23:45.695943Z","end":"2026-06-16T10:23:45.991036Z","steps":["trace[1129546491] 'read index received' (duration: 101.590297ms)","trace[1129546491] 'applied index is now lower than readState.Index' (duration: 193.500807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:45.991153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.219159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-16T10:23:45.991186Z","caller":"traceutil/trace.go:171","msg":"trace[1941224243] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:340; }","duration":"344.29785ms","start":"2026-06-16T10:23:45.646878Z","end":"2026-06-16T10:23:45.991176Z","steps":["trace[1941224243] 'agreement among raft nodes before linearized reading' (duration: 344.231549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:45.991196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.105641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-06-16T10:23:45.991249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:45.646855Z","time spent":"344.385791ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-06-16T10:23:45.991261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.241163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.107\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-16T10:23:45.991284Z","caller":"traceutil/trace.go:171","msg":"trace[2146281141] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:340; }","duration":"291.220662ms","start":"2026-06-16T10:23:45.700048Z","end":"2026-06-16T10:23:45.991268Z","steps":["trace[2146281141] 'agreement among raft nodes before linearized reading' (duration: 291.08974ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:45.991313Z","caller":"traceutil/trace.go:171","msg":"trace[685099171] range","detail":"{range_begin:/registry/masterleases/199.19.213.107; range_end:; response_count:1; response_revision:340; }","duration":"248.326614ms","start":"2026-06-16T10:23:45.742972Z","end":"2026-06-16T10:23:45.991299Z","steps":["trace[685099171] 'agreement among raft nodes before linearized reading' (duration: 248.180302ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:46.263203Z","caller":"traceutil/trace.go:171","msg":"trace[1116845992] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"265.147841ms","start":"2026-06-16T10:23:45.998024Z","end":"2026-06-16T10:23:46.263171Z","steps":["trace[1116845992] 'process raft request' (duration: 233.343338ms)","trace[1116845992] 'compare' (duration: 31.52497ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:46.263308Z","caller":"traceutil/trace.go:171","msg":"trace[1181426939] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"265.128841ms","start":"2026-06-16T10:23:45.99814Z","end":"2026-06-16T10:23:46.263269Z","steps":["trace[1181426939] 'process raft request' (duration: 264.936729ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:46.263406Z","caller":"traceutil/trace.go:171","msg":"trace[766563155] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"262.001677ms","start":"2026-06-16T10:23:46.001383Z","end":"2026-06-16T10:23:46.263385Z","steps":["trace[766563155] 'process raft request' (duration: 261.804795ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:46.26341Z","caller":"traceutil/trace.go:171","msg":"trace[2027819782] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"263.050099ms","start":"2026-06-16T10:23:46.000292Z","end":"2026-06-16T10:23:46.263342Z","steps":["trace[2027819782] 'process raft request' (duration: 262.839067ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:46.263643Z","caller":"traceutil/trace.go:171","msg":"trace[471843923] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"258.844903ms","start":"2026-06-16T10:23:46.004735Z","end":"2026-06-16T10:23:46.26358Z","steps":["trace[471843923] 'process raft request' (duration: 258.54284ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:46.264222Z","caller":"traceutil/trace.go:171","msg":"trace[142849220] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"256.323277ms","start":"2026-06-16T10:23:46.007876Z","end":"2026-06-16T10:23:46.264199Z","steps":["trace[142849220] 'process raft request' (duration: 255.453977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:46.648557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.808092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:46.648803Z","caller":"traceutil/trace.go:171","msg":"trace[147988168] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"379.202302ms","start":"2026-06-16T10:23:46.269573Z","end":"2026-06-16T10:23:46.648775Z","steps":["trace[147988168] 'process raft request' (duration: 173.102127ms)","trace[147988168] 'compare' (duration: 205.62393ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:46.648899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.269552Z","time spent":"379.306654ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:46.649039Z","caller":"traceutil/trace.go:171","msg":"trace[1388108504] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:363; }","duration":"379.377705ms","start":"2026-06-16T10:23:46.269648Z","end":"2026-06-16T10:23:46.649026Z","steps":["trace[1388108504] 'read index received' (duration: 18.751022ms)","trace[1388108504] 'applied index is now lower than readState.Index' (duration: 360.625843ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:46.649151Z","caller":"traceutil/trace.go:171","msg":"trace[1635036081] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"376.593144ms","start":"2026-06-16T10:23:46.272546Z","end":"2026-06-16T10:23:46.649139Z","steps":["trace[1635036081] 'process raft request' (duration: 376.325561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:46.649288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.272536Z","time spent":"376.700175ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:46.649301Z","caller":"traceutil/trace.go:171","msg":"trace[1022490784] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"372.852814ms","start":"2026-06-16T10:23:46.276415Z","end":"2026-06-16T10:23:46.649268Z","steps":["trace[1022490784] 'process raft request' (duration: 372.530891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:46.649551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.276402Z","time spent":"373.031316ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:46.649557Z","caller":"traceutil/trace.go:171","msg":"trace[1400104215] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"378.881949ms","start":"2026-06-16T10:23:46.270645Z","end":"2026-06-16T10:23:46.649527Z","steps":["trace[1400104215] 'process raft request' (duration: 378.02813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:46.649717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.058972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-16T10:23:46.649783Z","caller":"traceutil/trace.go:171","msg":"trace[1588766331] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:351; }","duration":"380.146552ms","start":"2026-06-16T10:23:46.269624Z","end":"2026-06-16T10:23:46.649771Z","steps":["trace[1588766331] 'agreement among raft nodes before linearized reading' (duration: 379.455045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:46.649815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.269613Z","time spent":"380.194363ms","remote":"127.0.0.1:40268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-06-16T10:23:46.649948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.270633Z","time spent":"379.140101ms","remote":"127.0.0.1:40496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:46.961371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.226571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:46.961454Z","caller":"traceutil/trace.go:171","msg":"trace[123971014] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"299.179819ms","start":"2026-06-16T10:23:46.662261Z","end":"2026-06-16T10:23:46.961441Z","steps":["trace[123971014] 'process raft request' (duration: 122.827866ms)","trace[123971014] 'compare' (duration: 176.114879ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:47.29896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.578115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:47.299085Z","caller":"traceutil/trace.go:171","msg":"trace[518416342] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"328.91965ms","start":"2026-06-16T10:23:46.970146Z","end":"2026-06-16T10:23:47.299065Z","steps":["trace[518416342] 'process raft request' (duration: 201.143903ms)","trace[518416342] 'compare' (duration: 127.454824ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:47.299161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:46.970128Z","time spent":"328.993252ms","remote":"127.0.0.1:40478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:47.299326Z","caller":"traceutil/trace.go:171","msg":"trace[309507214] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"237.216768ms","start":"2026-06-16T10:23:47.062092Z","end":"2026-06-16T10:23:47.299309Z","steps":["trace[309507214] 'process raft request' (duration: 237.115977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:47.551306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.920221ms","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-16T10:23:47.551352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.906269ms","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-16T10:23:47.551368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.240587ms","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-16T10:23:47.551401Z","caller":"traceutil/trace.go:171","msg":"trace[1378190643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"133.032632ms","start":"2026-06-16T10:23:47.418347Z","end":"2026-06-16T10:23:47.551379Z","steps":["trace[1378190643] 'range keys from in-memory index tree' (duration: 132.861161ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.551414Z","caller":"traceutil/trace.go:171","msg":"trace[1186527119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"129.968639ms","start":"2026-06-16T10:23:47.42142Z","end":"2026-06-16T10:23:47.551389Z","steps":["trace[1186527119] 'range keys from in-memory index tree' (duration: 129.867778ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.551457Z","caller":"traceutil/trace.go:171","msg":"trace[2039633677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"135.377438ms","start":"2026-06-16T10:23:47.416051Z","end":"2026-06-16T10:23:47.551429Z","steps":["trace[2039633677] 'range keys from in-memory index tree' (duration: 135.156715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:47.551561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.138259ms","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-16T10:23:47.551729Z","caller":"traceutil/trace.go:171","msg":"trace[284071949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"127.368402ms","start":"2026-06-16T10:23:47.424294Z","end":"2026-06-16T10:23:47.551662Z","steps":["trace[284071949] 'range keys from in-memory index tree' (duration: 126.983227ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.695881Z","caller":"traceutil/trace.go:171","msg":"trace[400441536] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"140.063928ms","start":"2026-06-16T10:23:47.555793Z","end":"2026-06-16T10:23:47.695857Z","steps":["trace[400441536] 'process raft request' (duration: 116.501355ms)","trace[400441536] 'compare' (duration: 23.365701ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:47.696196Z","caller":"traceutil/trace.go:171","msg":"trace[1691591633] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"140.057108ms","start":"2026-06-16T10:23:47.556115Z","end":"2026-06-16T10:23:47.696172Z","steps":["trace[1691591633] 'process raft request' (duration: 139.701935ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.696612Z","caller":"traceutil/trace.go:171","msg":"trace[877765969] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"140.20125ms","start":"2026-06-16T10:23:47.556387Z","end":"2026-06-16T10:23:47.696589Z","steps":["trace[877765969] 'process raft request' (duration: 139.714255ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.696661Z","caller":"traceutil/trace.go:171","msg":"trace[199587464] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"137.562291ms","start":"2026-06-16T10:23:47.559085Z","end":"2026-06-16T10:23:47.696647Z","steps":["trace[199587464] 'process raft request' (duration: 137.38614ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.872103Z","caller":"traceutil/trace.go:171","msg":"trace[169775135] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"171.779288ms","start":"2026-06-16T10:23:47.7003Z","end":"2026-06-16T10:23:47.872079Z","steps":["trace[169775135] 'read index received' (duration: 171.570326ms)","trace[169775135] 'applied index is now lower than readState.Index' (duration: 208.042µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:47.87224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.913859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-06-16T10:23:47.872215Z","caller":"traceutil/trace.go:171","msg":"trace[1538234911] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"248.608909ms","start":"2026-06-16T10:23:47.623571Z","end":"2026-06-16T10:23:47.87218Z","steps":["trace[1538234911] 'process raft request' (duration: 248.365677ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:47.872273Z","caller":"traceutil/trace.go:171","msg":"trace[2045113038] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:360; }","duration":"172.011301ms","start":"2026-06-16T10:23:47.700252Z","end":"2026-06-16T10:23:47.872263Z","steps":["trace[2045113038] 'agreement among raft nodes before linearized reading' (duration: 171.92249ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:48.128994Z","caller":"traceutil/trace.go:171","msg":"trace[605135413] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"248.86613ms","start":"2026-06-16T10:23:47.880101Z","end":"2026-06-16T10:23:48.128967Z","steps":["trace[605135413] 'process raft request' (duration: 248.690668ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:48.307553Z","caller":"traceutil/trace.go:171","msg":"trace[1466239702] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:376; }","duration":"221.192606ms","start":"2026-06-16T10:23:48.086332Z","end":"2026-06-16T10:23:48.307524Z","steps":["trace[1466239702] 'read index received' (duration: 42.577532ms)","trace[1466239702] 'applied index is now lower than readState.Index' (duration: 178.613744ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:48.307586Z","caller":"traceutil/trace.go:171","msg":"trace[755023808] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"322.061646ms","start":"2026-06-16T10:23:47.985501Z","end":"2026-06-16T10:23:48.307563Z","steps":["trace[755023808] 'process raft request' (duration: 235.546889ms)","trace[755023808] 'compare' (duration: 86.320155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:48.307841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.494989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-06-16T10:23:48.307899Z","caller":"traceutil/trace.go:171","msg":"trace[1406375723] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:362; }","duration":"221.601619ms","start":"2026-06-16T10:23:48.086283Z","end":"2026-06-16T10:23:48.307885Z","steps":["trace[1406375723] 'agreement among raft nodes before linearized reading' (duration: 221.349087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:48.307986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:47.985477Z","time spent":"322.35932ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:23:48.81291Z","caller":"traceutil/trace.go:171","msg":"trace[1583161177] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:381; }","duration":"217.993511ms","start":"2026-06-16T10:23:48.594888Z","end":"2026-06-16T10:23:48.812881Z","steps":["trace[1583161177] 'read index received' (duration: 217.743288ms)","trace[1583161177] 'applied index is now lower than readState.Index' (duration: 249.083µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:48.812986Z","caller":"traceutil/trace.go:171","msg":"trace[759623608] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"247.233111ms","start":"2026-06-16T10:23:48.56572Z","end":"2026-06-16T10:23:48.812953Z","steps":["trace[759623608] 'process raft request' (duration: 246.973119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:48.813075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.172183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:23:48.813128Z","caller":"traceutil/trace.go:171","msg":"trace[178758829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:365; }","duration":"218.835951ms","start":"2026-06-16T10:23:48.594278Z","end":"2026-06-16T10:23:48.813114Z","steps":["trace[178758829] 'agreement among raft nodes before linearized reading' (duration: 218.730159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:49.10797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.241267ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:49.108108Z","caller":"traceutil/trace.go:171","msg":"trace[1795203744] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"287.898683ms","start":"2026-06-16T10:23:48.820185Z","end":"2026-06-16T10:23:49.108083Z","steps":["trace[1795203744] 'process raft request' (duration: 99.422934ms)","trace[1795203744] 'compare' (duration: 187.924683ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:49.10867Z","caller":"traceutil/trace.go:171","msg":"trace[1201708472] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"285.891632ms","start":"2026-06-16T10:23:48.822752Z","end":"2026-06-16T10:23:49.108643Z","steps":["trace[1201708472] 'process raft request' (duration: 285.778681ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:49.831273Z","caller":"traceutil/trace.go:171","msg":"trace[266626792] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"122.928912ms","start":"2026-06-16T10:23:49.708278Z","end":"2026-06-16T10:23:49.831207Z","steps":["trace[266626792] 'process raft request' (duration: 122.875302ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:49.831346Z","caller":"traceutil/trace.go:171","msg":"trace[1838880274] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"124.978064ms","start":"2026-06-16T10:23:49.706336Z","end":"2026-06-16T10:23:49.831314Z","steps":["trace[1838880274] 'process raft request' (duration: 124.661011ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:53.80313Z","caller":"traceutil/trace.go:171","msg":"trace[1098977733] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"113.721578ms","start":"2026-06-16T10:23:53.689383Z","end":"2026-06-16T10:23:53.803105Z","steps":["trace[1098977733] 'process raft request' (duration: 113.371974ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:53.927512Z","caller":"traceutil/trace.go:171","msg":"trace[545049794] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"120.471606ms","start":"2026-06-16T10:23:53.807005Z","end":"2026-06-16T10:23:53.927476Z","steps":["trace[545049794] 'process raft request' (duration: 97.730085ms)","trace[545049794] 'compare' (duration: 22.571939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:56.043479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.858119ms","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-16T10:23:56.043563Z","caller":"traceutil/trace.go:171","msg":"trace[2116771993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:383; }","duration":"112.00245ms","start":"2026-06-16T10:23:55.93154Z","end":"2026-06-16T10:23:56.043542Z","steps":["trace[2116771993] 'range keys from in-memory index tree' (duration: 111.689777ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:58.399029Z","caller":"traceutil/trace.go:171","msg":"trace[456699102] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"331.405844ms","start":"2026-06-16T10:23:58.067599Z","end":"2026-06-16T10:23:58.399005Z","steps":["trace[456699102] 'read index received' (duration: 331.277183ms)","trace[456699102] 'applied index is now lower than readState.Index' (duration: 127.621µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:58.399075Z","caller":"traceutil/trace.go:171","msg":"trace[1821893585] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"500.082527ms","start":"2026-06-16T10:23:57.898965Z","end":"2026-06-16T10:23:58.399047Z","steps":["trace[1821893585] 'process raft request' (duration: 499.909546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:58.399258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.634977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-16T10:23:58.399283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:57.898949Z","time spent":"500.218598ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:58.399325Z","caller":"traceutil/trace.go:171","msg":"trace[984983283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:387; }","duration":"331.752518ms","start":"2026-06-16T10:23:58.067557Z","end":"2026-06-16T10:23:58.39931Z","steps":["trace[984983283] 'agreement among raft nodes before linearized reading' (duration: 331.589425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:58.399367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.067537Z","time spent":"331.821339ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T10:23:58.899542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4573298562626787972,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T10:23:59.477926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.709231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:23:59.478051Z","caller":"traceutil/trace.go:171","msg":"trace[174012829] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"1.352330876s","start":"2026-06-16T10:23:58.125698Z","end":"2026-06-16T10:23:59.478028Z","steps":["trace[174012829] 'process raft request' (duration: 1.207243231s)","trace[174012829] 'compare' (duration: 144.290357ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:23:59.478124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.12568Z","time spent":"1.352409287s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:23:59.564774Z","caller":"traceutil/trace.go:171","msg":"trace[430643888] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:406; }","duration":"1.165631268s","start":"2026-06-16T10:23:58.39912Z","end":"2026-06-16T10:23:59.564751Z","steps":["trace[430643888] 'read index received' (duration: 933.911958ms)","trace[430643888] 'applied index is now lower than readState.Index' (duration: 231.71831ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:59.564859Z","caller":"traceutil/trace.go:171","msg":"trace[1720117617] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"1.161449547s","start":"2026-06-16T10:23:58.403383Z","end":"2026-06-16T10:23:59.564833Z","steps":["trace[1720117617] 'process raft request' (duration: 1.161219765s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:59.564957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.482732952s","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-16T10:23:59.565014Z","caller":"traceutil/trace.go:171","msg":"trace[1364310123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:389; }","duration":"1.482813222s","start":"2026-06-16T10:23:58.082179Z","end":"2026-06-16T10:23:59.564992Z","steps":["trace[1364310123] 'agreement among raft nodes before linearized reading' (duration: 1.482666581s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:59.565048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.082167Z","time spent":"1.482871503s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T10:23:59.565248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.403361Z","time spent":"1.161555048s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:23:59.565277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.482355298s","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-16T10:23:59.565232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.403297621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:23:59.565357Z","caller":"traceutil/trace.go:171","msg":"trace[1207688587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:389; }","duration":"1.482470439s","start":"2026-06-16T10:23:58.082866Z","end":"2026-06-16T10:23:59.565337Z","steps":["trace[1207688587] 'agreement among raft nodes before linearized reading' (duration: 1.482279917s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:59.56542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.082859Z","time spent":"1.482551279s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T10:23:59.565444Z","caller":"traceutil/trace.go:171","msg":"trace[1301616142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"1.403525633s","start":"2026-06-16T10:23:58.161853Z","end":"2026-06-16T10:23:59.565379Z","steps":["trace[1301616142] 'agreement among raft nodes before linearized reading' (duration: 1.40326574s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:59.565577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:23:58.161828Z","time spent":"1.403733615s","remote":"127.0.0.1:40010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T10:23:59.686836Z","caller":"traceutil/trace.go:171","msg":"trace[332055288] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"116.557876ms","start":"2026-06-16T10:23:59.570244Z","end":"2026-06-16T10:23:59.686802Z","steps":["trace[332055288] 'process raft request' (duration: 66.938242ms)","trace[332055288] 'compare' (duration: 49.23822ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:23:59.686847Z","caller":"traceutil/trace.go:171","msg":"trace[75480586] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"115.88193ms","start":"2026-06-16T10:23:59.570936Z","end":"2026-06-16T10:23:59.686817Z","steps":["trace[75480586] 'process raft request' (duration: 115.721028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:23:59.686995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.784509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:23:59.687115Z","caller":"traceutil/trace.go:171","msg":"trace[1633052938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:391; }","duration":"112.94525ms","start":"2026-06-16T10:23:59.574159Z","end":"2026-06-16T10:23:59.687104Z","steps":["trace[1633052938] 'agreement among raft nodes before linearized reading' (duration: 112.761149ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:23:59.686861Z","caller":"traceutil/trace.go:171","msg":"trace[1863519559] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:408; }","duration":"112.569447ms","start":"2026-06-16T10:23:59.574187Z","end":"2026-06-16T10:23:59.686756Z","steps":["trace[1863519559] 'read index received' (duration: 63.039734ms)","trace[1863519559] 'applied index is now lower than readState.Index' (duration: 49.528133ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:01.796088Z","caller":"traceutil/trace.go:171","msg":"trace[324014139] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"100.839231ms","start":"2026-06-16T10:24:01.695222Z","end":"2026-06-16T10:24:01.796061Z","steps":["trace[324014139] 'process raft request' (duration: 80.899079ms)","trace[324014139] 'compare' (duration: 19.80946ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:02.546224Z","caller":"traceutil/trace.go:171","msg":"trace[2056477351] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"130.499689ms","start":"2026-06-16T10:24:02.4157Z","end":"2026-06-16T10:24:02.5462Z","steps":["trace[2056477351] 'process raft request' (duration: 130.356477ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:03.806872Z","caller":"traceutil/trace.go:171","msg":"trace[1304397938] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"100.349895ms","start":"2026-06-16T10:24:03.706495Z","end":"2026-06-16T10:24:03.806845Z","steps":["trace[1304397938] 'read index received' (duration: 100.056332ms)","trace[1304397938] 'applied index is now lower than readState.Index' (duration: 292.452µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:03.806935Z","caller":"traceutil/trace.go:171","msg":"trace[145553071] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"213.964024ms","start":"2026-06-16T10:24:03.592935Z","end":"2026-06-16T10:24:03.806899Z","steps":["trace[145553071] 'process raft request' (duration: 213.730442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:03.807079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.553836ms","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-16T10:24:03.807111Z","caller":"traceutil/trace.go:171","msg":"trace[1459762705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:397; }","duration":"100.645718ms","start":"2026-06-16T10:24:03.706454Z","end":"2026-06-16T10:24:03.8071Z","steps":["trace[1459762705] 'agreement among raft nodes before linearized reading' (duration: 100.551287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:04.523439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.791875ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:24:04.523764Z","caller":"traceutil/trace.go:171","msg":"trace[1103349606] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:397; }","duration":"623.143538ms","start":"2026-06-16T10:24:03.900582Z","end":"2026-06-16T10:24:04.523725Z","steps":["trace[1103349606] 'range keys from in-memory index tree' (duration: 622.762474ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:04.524498Z","caller":"traceutil/trace.go:171","msg":"trace[1871692624] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:417; }","duration":"362.187714ms","start":"2026-06-16T10:24:04.162269Z","end":"2026-06-16T10:24:04.524457Z","steps":["trace[1871692624] 'read index received' (duration: 350.263122ms)","trace[1871692624] 'applied index is now lower than readState.Index' (duration: 11.923832ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:04.524562Z","caller":"traceutil/trace.go:171","msg":"trace[735405766] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"712.716469ms","start":"2026-06-16T10:24:03.811825Z","end":"2026-06-16T10:24:04.524542Z","steps":["trace[735405766] 'process raft request' (duration: 700.685655ms)","trace[735405766] 'compare' (duration: 11.076845ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:04.524623Z","caller":"traceutil/trace.go:171","msg":"trace[12057814] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"712.540807ms","start":"2026-06-16T10:24:03.812047Z","end":"2026-06-16T10:24:04.524588Z","steps":["trace[12057814] 'process raft request' (duration: 712.320115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:04.524649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.336425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:24:04.524679Z","caller":"traceutil/trace.go:171","msg":"trace[305995031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"362.444156ms","start":"2026-06-16T10:24:04.162226Z","end":"2026-06-16T10:24:04.52467Z","steps":["trace[305995031] 'agreement among raft nodes before linearized reading' (duration: 362.342535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:04.52468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:03.811804Z","time spent":"712.81966ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:24:04.524724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:04.162204Z","time spent":"362.494786ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T10:24:04.524726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:03.812019Z","time spent":"712.651228ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:24:23.547424Z","caller":"traceutil/trace.go:171","msg":"trace[1043389517] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"274.62146ms","start":"2026-06-16T10:24:23.272778Z","end":"2026-06-16T10:24:23.5474Z","steps":["trace[1043389517] 'process raft request' (duration: 274.501006ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.562996Z","caller":"traceutil/trace.go:171","msg":"trace[1282092769] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"287.474623ms","start":"2026-06-16T10:24:23.275487Z","end":"2026-06-16T10:24:23.562962Z","steps":["trace[1282092769] 'process raft request' (duration: 287.192735ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.56314Z","caller":"traceutil/trace.go:171","msg":"trace[107339283] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"281.044926ms","start":"2026-06-16T10:24:23.282079Z","end":"2026-06-16T10:24:23.563124Z","steps":["trace[107339283] 'process raft request' (duration: 280.814199ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563296Z","caller":"traceutil/trace.go:171","msg":"trace[1414691684] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"278.934381ms","start":"2026-06-16T10:24:23.284355Z","end":"2026-06-16T10:24:23.56329Z","steps":["trace[1414691684] 'process raft request' (duration: 278.750436ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563251Z","caller":"traceutil/trace.go:171","msg":"trace[1956023058] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"279.764467ms","start":"2026-06-16T10:24:23.283469Z","end":"2026-06-16T10:24:23.563233Z","steps":["trace[1956023058] 'process raft request' (duration: 279.590902ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563408Z","caller":"traceutil/trace.go:171","msg":"trace[387139084] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"278.515599ms","start":"2026-06-16T10:24:23.284885Z","end":"2026-06-16T10:24:23.5634Z","steps":["trace[387139084] 'process raft request' (duration: 278.305252ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563469Z","caller":"traceutil/trace.go:171","msg":"trace[403420276] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"281.013205ms","start":"2026-06-16T10:24:23.282149Z","end":"2026-06-16T10:24:23.563162Z","steps":["trace[403420276] 'process raft request' (duration: 280.871591ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563557Z","caller":"traceutil/trace.go:171","msg":"trace[460684715] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"273.720602ms","start":"2026-06-16T10:24:23.289796Z","end":"2026-06-16T10:24:23.563517Z","steps":["trace[460684715] 'process raft request' (duration: 273.497825ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563094Z","caller":"traceutil/trace.go:171","msg":"trace[1647220400] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"287.478483ms","start":"2026-06-16T10:24:23.275588Z","end":"2026-06-16T10:24:23.563067Z","steps":["trace[1647220400] 'process raft request' (duration: 287.262297ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563692Z","caller":"traceutil/trace.go:171","msg":"trace[1482196640] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"270.604378ms","start":"2026-06-16T10:24:23.293063Z","end":"2026-06-16T10:24:23.563668Z","steps":["trace[1482196640] 'process raft request' (duration: 270.314188ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.563883Z","caller":"traceutil/trace.go:171","msg":"trace[1771863954] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"240.964961ms","start":"2026-06-16T10:24:23.322905Z","end":"2026-06-16T10:24:23.56387Z","steps":["trace[1771863954] 'process raft request' (duration: 240.584438ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:23.5639Z","caller":"traceutil/trace.go:171","msg":"trace[1596366515] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"121.445906ms","start":"2026-06-16T10:24:23.442423Z","end":"2026-06-16T10:24:23.563869Z","steps":["trace[1596366515] 'process raft request' (duration: 121.310582ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:24.046283Z","caller":"traceutil/trace.go:171","msg":"trace[857950986] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"122.976748ms","start":"2026-06-16T10:24:23.923281Z","end":"2026-06-16T10:24:24.046257Z","steps":["trace[857950986] 'process raft request' (duration: 94.673722ms)","trace[857950986] 'compare' (duration: 28.070209ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:24.098143Z","caller":"traceutil/trace.go:171","msg":"trace[1712103648] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"154.074273ms","start":"2026-06-16T10:24:23.944044Z","end":"2026-06-16T10:24:24.098118Z","steps":["trace[1712103648] 'process raft request' (duration: 153.851016ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:29.854627Z","caller":"traceutil/trace.go:171","msg":"trace[1383718538] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"266.547017ms","start":"2026-06-16T10:24:29.588013Z","end":"2026-06-16T10:24:29.85456Z","steps":["trace[1383718538] 'process raft request' (duration: 259.561707ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:30.659417Z","caller":"traceutil/trace.go:171","msg":"trace[1498597171] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"315.982687ms","start":"2026-06-16T10:24:30.343381Z","end":"2026-06-16T10:24:30.659364Z","steps":["trace[1498597171] 'process raft request' (duration: 315.114452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:30.659614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:30.34335Z","time spent":"316.158722ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:24:31.339723Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4573298562626788408,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T10:24:31.689366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.756597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:24:31.69001Z","caller":"traceutil/trace.go:171","msg":"trace[634816361] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.018834244s","start":"2026-06-16T10:24:30.671157Z","end":"2026-06-16T10:24:31.689991Z","steps":["trace[634816361] 'process raft request' (duration: 1.01869707s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:31.690152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:30.671149Z","time spent":"1.018930918s","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:24:31.690229Z","caller":"traceutil/trace.go:171","msg":"trace[1096012593] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.024953679s","start":"2026-06-16T10:24:30.665253Z","end":"2026-06-16T10:24:31.690206Z","steps":["trace[1096012593] 'process raft request' (duration: 92.231836ms)","trace[1096012593] 'compare' (duration: 931.351595ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:24:31.690348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:30.665244Z","time spent":"1.025037101s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:24:31.695729Z","caller":"traceutil/trace.go:171","msg":"trace[1971420988] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"984.971689ms","start":"2026-06-16T10:24:30.710724Z","end":"2026-06-16T10:24:31.695695Z","steps":["trace[1971420988] 'process raft request' (duration: 984.859546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:31.695918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:30.710698Z","time spent":"985.154884ms","remote":"127.0.0.1:40240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T10:24:31.728161Z","caller":"traceutil/trace.go:171","msg":"trace[1520273879] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"888.771041ms","start":"2026-06-16T10:24:30.839358Z","end":"2026-06-16T10:24:31.728129Z","steps":["trace[1520273879] 'read index received' (duration: 856.393478ms)","trace[1520273879] 'applied index is now lower than readState.Index' (duration: 32.375793ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:24:31.728409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.892367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T10:24:31.728455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.08157ms","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-16T10:24:31.728485Z","caller":"traceutil/trace.go:171","msg":"trace[1449287825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"569.00657ms","start":"2026-06-16T10:24:31.159465Z","end":"2026-06-16T10:24:31.728471Z","steps":["trace[1449287825] 'agreement among raft nodes before linearized reading' (duration: 568.875516ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:31.728511Z","caller":"traceutil/trace.go:171","msg":"trace[2079828813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"889.182873ms","start":"2026-06-16T10:24:30.839311Z","end":"2026-06-16T10:24:31.728494Z","steps":["trace[2079828813] 'agreement among raft nodes before linearized reading' (duration: 888.979727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:31.728568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:30.839292Z","time spent":"889.263675ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T10:24:31.728524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:24:31.159451Z","time spent":"569.065732ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T10:24:48.064585Z","caller":"traceutil/trace.go:171","msg":"trace[284105240] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"288.348879ms","start":"2026-06-16T10:24:47.776206Z","end":"2026-06-16T10:24:48.064555Z","steps":["trace[284105240] 'read index received' (duration: 288.067682ms)","trace[284105240] 'applied index is now lower than readState.Index' (duration: 280.137µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:24:48.064631Z","caller":"traceutil/trace.go:171","msg":"trace[1728320363] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"295.008821ms","start":"2026-06-16T10:24:47.7696Z","end":"2026-06-16T10:24:48.064609Z","steps":["trace[1728320363] 'process raft request' (duration: 294.769874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:48.064851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.614946ms","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-16T10:24:48.064917Z","caller":"traceutil/trace.go:171","msg":"trace[302623199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"288.731668ms","start":"2026-06-16T10:24:47.776173Z","end":"2026-06-16T10:24:48.064905Z","steps":["trace[302623199] 'agreement among raft nodes before linearized reading' (duration: 288.504363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:24:48.064881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.739025ms","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-16T10:24:48.06505Z","caller":"traceutil/trace.go:171","msg":"trace[1663440387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:783; }","duration":"254.9326ms","start":"2026-06-16T10:24:47.810108Z","end":"2026-06-16T10:24:48.065041Z","steps":["trace[1663440387] 'agreement among raft nodes before linearized reading' (duration: 254.712885ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:24:51.972747Z","caller":"traceutil/trace.go:171","msg":"trace[1126184520] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"112.222252ms","start":"2026-06-16T10:24:51.860491Z","end":"2026-06-16T10:24:51.972714Z","steps":["trace[1126184520] 'process raft request' (duration: 89.441859ms)","trace[1126184520] 'compare' (duration: 22.62777ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:25:18.782173Z","caller":"traceutil/trace.go:171","msg":"trace[1245361545] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"464.340914ms","start":"2026-06-16T10:25:18.317807Z","end":"2026-06-16T10:25:18.782148Z","steps":["trace[1245361545] 'process raft request' (duration: 464.15486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:25:18.782329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:25:18.31779Z","time spent":"464.459346ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:25:18.827993Z","caller":"traceutil/trace.go:171","msg":"trace[164947981] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1223; }","duration":"507.220781ms","start":"2026-06-16T10:25:18.320746Z","end":"2026-06-16T10:25:18.827967Z","steps":["trace[164947981] 'read index received' (duration: 461.224864ms)","trace[164947981] 'applied index is now lower than readState.Index' (duration: 45.994847ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:25:18.828076Z","caller":"traceutil/trace.go:171","msg":"trace[1831614536] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"508.772871ms","start":"2026-06-16T10:25:18.319265Z","end":"2026-06-16T10:25:18.828038Z","steps":["trace[1831614536] 'process raft request' (duration: 504.563732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:25:18.828185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.423635ms","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-16T10:25:18.828401Z","caller":"traceutil/trace.go:171","msg":"trace[566585504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1183; }","duration":"507.682819ms","start":"2026-06-16T10:25:18.320691Z","end":"2026-06-16T10:25:18.828374Z","steps":["trace[566585504] 'agreement among raft nodes before linearized reading' (duration: 507.367914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:25:18.828436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:25:18.319241Z","time spent":"509.074896ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:25:18.828492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:25:18.320671Z","time spent":"507.787052ms","remote":"127.0.0.1:40256","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-16T10:25:35.113293Z","caller":"traceutil/trace.go:171","msg":"trace[1745825557] linearizableReadLoop","detail":"{readStateIndex:1371; appliedIndex:1370; }","duration":"123.605034ms","start":"2026-06-16T10:25:34.989659Z","end":"2026-06-16T10:25:35.113264Z","steps":["trace[1745825557] 'read index received' (duration: 40.086408ms)","trace[1745825557] 'applied index is now lower than readState.Index' (duration: 83.517476ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:25:35.113327Z","caller":"traceutil/trace.go:171","msg":"trace[1832878756] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"188.729548ms","start":"2026-06-16T10:25:34.924563Z","end":"2026-06-16T10:25:35.113292Z","steps":["trace[1832878756] 'process raft request' (duration: 105.235152ms)","trace[1832878756] 'compare' (duration: 83.340953ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:25:35.113579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.91294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-rq5d9\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-06-16T10:25:35.113687Z","caller":"traceutil/trace.go:171","msg":"trace[77883348] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-rq5d9; range_end:; response_count:1; response_revision:1321; }","duration":"124.075463ms","start":"2026-06-16T10:25:34.989591Z","end":"2026-06-16T10:25:35.113666Z","steps":["trace[77883348] 'agreement among raft nodes before linearized reading' (duration: 123.824788ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:25:43.010837Z","caller":"traceutil/trace.go:171","msg":"trace[1308066570] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"114.243337ms","start":"2026-06-16T10:25:42.896551Z","end":"2026-06-16T10:25:43.010794Z","steps":["trace[1308066570] 'process raft request' (duration: 114.048074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:25:43.259982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.810306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:25:43.260068Z","caller":"traceutil/trace.go:171","msg":"trace[1374945347] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1501; }","duration":"115.705471ms","start":"2026-06-16T10:25:43.14435Z","end":"2026-06-16T10:25:43.260055Z","steps":["trace[1374945347] 'read index received' (duration: 35.43µs)","trace[1374945347] 'applied index is now lower than readState.Index' (duration: 115.668911ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:25:43.260132Z","caller":"traceutil/trace.go:171","msg":"trace[1596433240] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"245.752182ms","start":"2026-06-16T10:25:43.01437Z","end":"2026-06-16T10:25:43.260122Z","steps":["trace[1596433240] 'process raft request' (duration: 112.736223ms)","trace[1596433240] 'compare' (duration: 132.461939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:25:43.260246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.041412ms","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-16T10:25:43.260316Z","caller":"traceutil/trace.go:171","msg":"trace[1504175345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1449; }","duration":"112.137603ms","start":"2026-06-16T10:25:43.14816Z","end":"2026-06-16T10:25:43.260297Z","steps":["trace[1504175345] 'agreement among raft nodes before linearized reading' (duration: 111.97017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:25:43.260357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.999455ms","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-16T10:25:43.260398Z","caller":"traceutil/trace.go:171","msg":"trace[1251524877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1449; }","duration":"116.043536ms","start":"2026-06-16T10:25:43.144345Z","end":"2026-06-16T10:25:43.260388Z","steps":["trace[1251524877] 'agreement among raft nodes before linearized reading' (duration: 115.892214ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:25:51.608531Z","caller":"traceutil/trace.go:171","msg":"trace[810532353] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"202.475009ms","start":"2026-06-16T10:25:51.406042Z","end":"2026-06-16T10:25:51.608517Z","steps":["trace[810532353] 'process raft request' (duration: 202.393758ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:07.400495Z","caller":"traceutil/trace.go:171","msg":"trace[1461697016] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"217.360902ms","start":"2026-06-16T10:26:07.183114Z","end":"2026-06-16T10:26:07.400475Z","steps":["trace[1461697016] 'read index received' (duration: 217.16546ms)","trace[1461697016] 'applied index is now lower than readState.Index' (duration: 194.482µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:07.400625Z","caller":"traceutil/trace.go:171","msg":"trace[754402639] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"245.816598ms","start":"2026-06-16T10:26:07.154797Z","end":"2026-06-16T10:26:07.400613Z","steps":["trace[754402639] 'process raft request' (duration: 245.522294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:07.40085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.751247ms","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-16T10:26:07.400902Z","caller":"traceutil/trace.go:171","msg":"trace[479058238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1856; }","duration":"182.844099ms","start":"2026-06-16T10:26:07.218049Z","end":"2026-06-16T10:26:07.400893Z","steps":["trace[479058238] 'agreement among raft nodes before linearized reading' (duration: 182.712737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:07.401145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.026761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-16T10:26:07.401382Z","caller":"traceutil/trace.go:171","msg":"trace[1762315075] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1856; }","duration":"218.136953ms","start":"2026-06-16T10:26:07.183099Z","end":"2026-06-16T10:26:07.401236Z","steps":["trace[1762315075] 'agreement among raft nodes before linearized reading' (duration: 217.782588ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:07.768244Z","caller":"traceutil/trace.go:171","msg":"trace[2072822283] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"363.017319ms","start":"2026-06-16T10:26:07.405198Z","end":"2026-06-16T10:26:07.768216Z","steps":["trace[2072822283] 'process raft request' (duration: 287.630213ms)","trace[2072822283] 'compare' (duration: 75.092232ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:26:07.768367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:07.405168Z","time spent":"363.128591ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:07.76909Z","caller":"traceutil/trace.go:171","msg":"trace[1674637495] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"363.108651ms","start":"2026-06-16T10:26:07.40597Z","end":"2026-06-16T10:26:07.769078Z","steps":["trace[1674637495] 'process raft request' (duration: 362.579243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:07.769149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:07.405951Z","time spent":"363.171433ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:07.769684Z","caller":"traceutil/trace.go:171","msg":"trace[1758993372] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"235.881845ms","start":"2026-06-16T10:26:07.533791Z","end":"2026-06-16T10:26:07.769673Z","steps":["trace[1758993372] 'process raft request' (duration: 235.704243ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:07.76954Z","caller":"traceutil/trace.go:171","msg":"trace[797507976] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1935; }","duration":"217.414432ms","start":"2026-06-16T10:26:07.552115Z","end":"2026-06-16T10:26:07.76953Z","steps":["trace[797507976] 'read index received' (duration: 140.88622ms)","trace[797507976] 'applied index is now lower than readState.Index' (duration: 76.527592ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:07.769582Z","caller":"traceutil/trace.go:171","msg":"trace[239222114] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"280.177568ms","start":"2026-06-16T10:26:07.489359Z","end":"2026-06-16T10:26:07.769536Z","steps":["trace[239222114] 'process raft request' (duration: 279.672661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:07.769651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.532394ms","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-16T10:26:07.769898Z","caller":"traceutil/trace.go:171","msg":"trace[1852900850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1860; }","duration":"217.828658ms","start":"2026-06-16T10:26:07.55206Z","end":"2026-06-16T10:26:07.769889Z","steps":["trace[1852900850] 'agreement among raft nodes before linearized reading' (duration: 217.500684ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:19.933608Z","caller":"traceutil/trace.go:171","msg":"trace[1857107666] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"131.69648ms","start":"2026-06-16T10:26:19.801871Z","end":"2026-06-16T10:26:19.933568Z","steps":["trace[1857107666] 'process raft request' (duration: 103.811401ms)","trace[1857107666] 'compare' (duration: 27.632756ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:20.12468Z","caller":"traceutil/trace.go:171","msg":"trace[1103813604] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"185.582075ms","start":"2026-06-16T10:26:19.939057Z","end":"2026-06-16T10:26:20.124639Z","steps":["trace[1103813604] 'process raft request' (duration: 119.191406ms)","trace[1103813604] 'compare' (duration: 66.158726ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:20.124748Z","caller":"traceutil/trace.go:171","msg":"trace[1909552924] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"143.97947ms","start":"2026-06-16T10:26:19.980744Z","end":"2026-06-16T10:26:20.124723Z","steps":["trace[1909552924] 'process raft request' (duration: 143.931999ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:20.124825Z","caller":"traceutil/trace.go:171","msg":"trace[1323445485] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"185.707917ms","start":"2026-06-16T10:26:19.939079Z","end":"2026-06-16T10:26:20.124787Z","steps":["trace[1323445485] 'process raft request' (duration: 185.522225ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:20.124878Z","caller":"traceutil/trace.go:171","msg":"trace[244121877] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"185.672807ms","start":"2026-06-16T10:26:19.939168Z","end":"2026-06-16T10:26:20.124841Z","steps":["trace[244121877] 'process raft request' (duration: 185.471674ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:20.124927Z","caller":"traceutil/trace.go:171","msg":"trace[426210029] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"185.828149ms","start":"2026-06-16T10:26:19.939081Z","end":"2026-06-16T10:26:20.124909Z","steps":["trace[426210029] 'process raft request' (duration: 185.457244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.482306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4573298562626791137,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-16T10:26:22.645524Z","caller":"traceutil/trace.go:171","msg":"trace[1968781480] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"780.129641ms","start":"2026-06-16T10:26:21.865375Z","end":"2026-06-16T10:26:22.645505Z","steps":["trace[1968781480] 'process raft request' (duration: 779.989619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.645655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:21.865359Z","time spent":"780.231723ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:22.649719Z","caller":"traceutil/trace.go:171","msg":"trace[1262423927] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"710.486223ms","start":"2026-06-16T10:26:21.939208Z","end":"2026-06-16T10:26:22.649694Z","steps":["trace[1262423927] 'process raft request' (duration: 710.287829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.649926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:21.939194Z","time spent":"710.601254ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:22.649961Z","caller":"traceutil/trace.go:171","msg":"trace[1097732295] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2057; }","duration":"668.76273ms","start":"2026-06-16T10:26:21.981176Z","end":"2026-06-16T10:26:22.649939Z","steps":["trace[1097732295] 'read index received' (duration: 664.248059ms)","trace[1097732295] 'applied index is now lower than readState.Index' (duration: 4.513371ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:22.64999Z","caller":"traceutil/trace.go:171","msg":"trace[166392328] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"634.58254ms","start":"2026-06-16T10:26:22.015361Z","end":"2026-06-16T10:26:22.649943Z","steps":["trace[166392328] 'process raft request' (duration: 634.290386ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:22.650006Z","caller":"traceutil/trace.go:171","msg":"trace[1335070087] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"519.385082ms","start":"2026-06-16T10:26:22.130601Z","end":"2026-06-16T10:26:22.649986Z","steps":["trace[1335070087] 'process raft request' (duration: 519.21765ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:22.650116Z","caller":"traceutil/trace.go:171","msg":"trace[1331453311] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"240.754866ms","start":"2026-06-16T10:26:22.409317Z","end":"2026-06-16T10:26:22.650072Z","steps":["trace[1331453311] 'process raft request' (duration: 240.583864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.650181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.015335Z","time spent":"634.731542ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:26:22.650223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.026184ms","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-16T10:26:22.650225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.130587Z","time spent":"519.592834ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:22.650264Z","caller":"traceutil/trace.go:171","msg":"trace[246155623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1979; }","duration":"669.104164ms","start":"2026-06-16T10:26:21.981149Z","end":"2026-06-16T10:26:22.650253Z","steps":["trace[246155623] 'agreement among raft nodes before linearized reading' (duration: 668.921502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.65036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:21.981139Z","time spent":"669.201575ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T10:26:22.650368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.646961ms","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":"warn","ts":"2026-06-16T10:26:22.650435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.50565ms","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-16T10:26:22.650437Z","caller":"traceutil/trace.go:171","msg":"trace[1402967785] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1979; }","duration":"521.771422ms","start":"2026-06-16T10:26:22.128646Z","end":"2026-06-16T10:26:22.650417Z","steps":["trace[1402967785] 'agreement among raft nodes before linearized reading' (duration: 521.463328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.650489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.128632Z","time spent":"521.842784ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-16T10:26:22.650477Z","caller":"traceutil/trace.go:171","msg":"trace[729795751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1979; }","duration":"521.58142ms","start":"2026-06-16T10:26:22.128878Z","end":"2026-06-16T10:26:22.65046Z","steps":["trace[729795751] 'agreement among raft nodes before linearized reading' (duration: 521.428138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.650545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.844984ms","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-16T10:26:22.650614Z","caller":"traceutil/trace.go:171","msg":"trace[2078284489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1979; }","duration":"521.955345ms","start":"2026-06-16T10:26:22.128642Z","end":"2026-06-16T10:26:22.650598Z","steps":["trace[2078284489] 'agreement among raft nodes before linearized reading' (duration: 521.782333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.650657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.128593Z","time spent":"522.053556ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T10:26:22.650559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.128857Z","time spent":"521.693752ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T10:26:22.651019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.771783ms","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-16T10:26:22.651073Z","caller":"traceutil/trace.go:171","msg":"trace[1211200849] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1979; }","duration":"521.846204ms","start":"2026-06-16T10:26:22.129215Z","end":"2026-06-16T10:26:22.651061Z","steps":["trace[1211200849] 'agreement among raft nodes before linearized reading' (duration: 520.907552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:22.651151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:22.129202Z","time spent":"521.938285ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T10:26:38.874471Z","caller":"traceutil/trace.go:171","msg":"trace[1769400602] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"104.492342ms","start":"2026-06-16T10:26:38.769947Z","end":"2026-06-16T10:26:38.874439Z","steps":["trace[1769400602] 'process raft request' (duration: 104.286999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:38.874567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.858277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-16T10:26:38.874699Z","caller":"traceutil/trace.go:171","msg":"trace[710102470] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2086; }","duration":"105.012459ms","start":"2026-06-16T10:26:38.769663Z","end":"2026-06-16T10:26:38.874675Z","steps":["trace[710102470] 'agreement among raft nodes before linearized reading' (duration: 104.706845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:38.874717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.47548ms","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":"warn","ts":"2026-06-16T10:26:38.874749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.992198ms","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-16T10:26:38.874806Z","caller":"traceutil/trace.go:171","msg":"trace[791580974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2086; }","duration":"103.587321ms","start":"2026-06-16T10:26:38.771196Z","end":"2026-06-16T10:26:38.874784Z","steps":["trace[791580974] 'agreement among raft nodes before linearized reading' (duration: 103.311757ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:38.874809Z","caller":"traceutil/trace.go:171","msg":"trace[374719105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2086; }","duration":"105.063879ms","start":"2026-06-16T10:26:38.769728Z","end":"2026-06-16T10:26:38.874792Z","steps":["trace[374719105] 'agreement among raft nodes before linearized reading' (duration: 104.924317ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:39.098205Z","caller":"traceutil/trace.go:171","msg":"trace[351723326] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"219.618206ms","start":"2026-06-16T10:26:38.878563Z","end":"2026-06-16T10:26:39.098181Z","steps":["trace[351723326] 'process raft request' (duration: 219.521694ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:39.098248Z","caller":"traceutil/trace.go:171","msg":"trace[498203529] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"220.453077ms","start":"2026-06-16T10:26:38.877772Z","end":"2026-06-16T10:26:39.098225Z","steps":["trace[498203529] 'process raft request' (duration: 216.015761ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:39.955359Z","caller":"traceutil/trace.go:171","msg":"trace[521132945] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"102.717377ms","start":"2026-06-16T10:26:39.852611Z","end":"2026-06-16T10:26:39.955329Z","steps":["trace[521132945] 'process raft request' (duration: 102.476424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.168299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.761555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:26:41.168474Z","caller":"traceutil/trace.go:171","msg":"trace[1456776390] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"431.651525ms","start":"2026-06-16T10:26:40.736808Z","end":"2026-06-16T10:26:41.16846Z","steps":["trace[1456776390] 'process raft request' (duration: 431.569904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.168522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.736785Z","time spent":"431.714275ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:41.168969Z","caller":"traceutil/trace.go:171","msg":"trace[1821239286] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"550.743724ms","start":"2026-06-16T10:26:40.618197Z","end":"2026-06-16T10:26:41.168941Z","steps":["trace[1821239286] 'process raft request' (duration: 137.23026ms)","trace[1821239286] 'compare' (duration: 412.633763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:26:41.169082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.618173Z","time spent":"550.850765ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:26:41.565844Z","caller":"traceutil/trace.go:171","msg":"trace[453880721] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2178; }","duration":"750.223817ms","start":"2026-06-16T10:26:40.815598Z","end":"2026-06-16T10:26:41.565822Z","steps":["trace[453880721] 'read index received' (duration: 75.215793ms)","trace[453880721] 'applied index is now lower than readState.Index' (duration: 675.007194ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:26:41.565883Z","caller":"traceutil/trace.go:171","msg":"trace[1909720333] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"805.544079ms","start":"2026-06-16T10:26:40.760305Z","end":"2026-06-16T10:26:41.565849Z","steps":["trace[1909720333] 'process raft request' (duration: 804.385194ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:41.565959Z","caller":"traceutil/trace.go:171","msg":"trace[1631449018] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"803.926588ms","start":"2026-06-16T10:26:40.762008Z","end":"2026-06-16T10:26:41.565934Z","steps":["trace[1631449018] 'process raft request' (duration: 803.781206ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:41.565944Z","caller":"traceutil/trace.go:171","msg":"trace[1051676874] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"805.502927ms","start":"2026-06-16T10:26:40.760405Z","end":"2026-06-16T10:26:41.565908Z","steps":["trace[1051676874] 'process raft request' (duration: 805.341425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.566102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.761997Z","time spent":"804.006908ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:26:41.566122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.507672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-16T10:26:41.566163Z","caller":"traceutil/trace.go:171","msg":"trace[1011332038] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2096; }","duration":"750.616022ms","start":"2026-06-16T10:26:40.815538Z","end":"2026-06-16T10:26:41.566154Z","steps":["trace[1011332038] 'agreement among raft nodes before linearized reading' (duration: 750.40485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.566162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.760375Z","time spent":"805.659799ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:26:41.566193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.815509Z","time spent":"750.677003ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-16T10:26:41.566208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.760278Z","time spent":"805.71094ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:26:41.574212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.891065ms","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-16T10:26:41.574318Z","caller":"traceutil/trace.go:171","msg":"trace[1438442556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2096; }","duration":"721.057117ms","start":"2026-06-16T10:26:40.853247Z","end":"2026-06-16T10:26:41.574304Z","steps":["trace[1438442556] 'agreement among raft nodes before linearized reading' (duration: 720.875445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.574335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.732763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T10:26:41.574362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.661186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-06-16T10:26:41.574387Z","caller":"traceutil/trace.go:171","msg":"trace[927731890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2096; }","duration":"411.810934ms","start":"2026-06-16T10:26:41.162563Z","end":"2026-06-16T10:26:41.574374Z","steps":["trace[927731890] 'agreement among raft nodes before linearized reading' (duration: 411.747643ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:41.574401Z","caller":"traceutil/trace.go:171","msg":"trace[1074000373] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2096; }","duration":"684.727086ms","start":"2026-06-16T10:26:40.889663Z","end":"2026-06-16T10:26:41.57439Z","steps":["trace[1074000373] 'agreement among raft nodes before linearized reading' (duration: 684.576155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.574426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:41.162543Z","time spent":"411.875585ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.889649Z","time spent":"684.777557ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.639788ms","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-16T10:26:41.574623Z","caller":"traceutil/trace.go:171","msg":"trace[10783892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2096; }","duration":"666.976012ms","start":"2026-06-16T10:26:40.907629Z","end":"2026-06-16T10:26:41.574605Z","steps":["trace[10783892] 'agreement among raft nodes before linearized reading' (duration: 666.570657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.574708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.907616Z","time spent":"667.041793ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.386389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-16T10:26:41.574745Z","caller":"traceutil/trace.go:171","msg":"trace[55911248] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2096; }","duration":"612.448731ms","start":"2026-06-16T10:26:40.962286Z","end":"2026-06-16T10:26:41.574735Z","steps":["trace[55911248] 'agreement among raft nodes before linearized reading' (duration: 612.37732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.574771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.962255Z","time spent":"612.511681ms","remote":"127.0.0.1:40412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.853223Z","time spent":"721.164088ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.464157ms","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-16T10:26:41.574904Z","caller":"traceutil/trace.go:171","msg":"trace[1463464124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2097; }","duration":"693.527658ms","start":"2026-06-16T10:26:40.881367Z","end":"2026-06-16T10:26:41.574894Z","steps":["trace[1463464124] 'agreement among raft nodes before linearized reading' (duration: 693.380806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.574938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:40.881347Z","time spent":"693.582988ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T10:26:41.574272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.191307ms","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-16T10:26:41.574915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.731083ms","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-16T10:26:41.575059Z","caller":"traceutil/trace.go:171","msg":"trace[1595110182] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2096; }","duration":"472.923955ms","start":"2026-06-16T10:26:41.102104Z","end":"2026-06-16T10:26:41.575028Z","steps":["trace[1595110182] 'agreement among raft nodes before linearized reading' (duration: 472.49612ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:26:41.574988Z","caller":"traceutil/trace.go:171","msg":"trace[718092488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2096; }","duration":"472.945127ms","start":"2026-06-16T10:26:41.102035Z","end":"2026-06-16T10:26:41.57498Z","steps":["trace[718092488] 'agreement among raft nodes before linearized reading' (duration: 472.124197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:26:41.575144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:41.102018Z","time spent":"473.114929ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T10:26:41.575559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:26:41.102087Z","time spent":"473.059788ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-16T10:27:42.011971Z","caller":"traceutil/trace.go:171","msg":"trace[787746467] transaction","detail":"{read_only:false; response_revision:2466; number_of_response:1; }","duration":"184.123037ms","start":"2026-06-16T10:27:41.827823Z","end":"2026-06-16T10:27:42.011946Z","steps":["trace[787746467] 'process raft request' (duration: 167.356059ms)","trace[787746467] 'compare' (duration: 16.604506ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:27:42.012211Z","caller":"traceutil/trace.go:171","msg":"trace[988212659] transaction","detail":"{read_only:false; response_revision:2467; number_of_response:1; }","duration":"181.74075ms","start":"2026-06-16T10:27:41.830454Z","end":"2026-06-16T10:27:42.012195Z","steps":["trace[988212659] 'process raft request' (duration: 181.453017ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:27:50.963672Z","caller":"traceutil/trace.go:171","msg":"trace[63866048] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"318.386627ms","start":"2026-06-16T10:27:50.645262Z","end":"2026-06-16T10:27:50.963649Z","steps":["trace[63866048] 'process raft request' (duration: 318.252806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:27:50.963811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:27:50.645238Z","time spent":"318.507369ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:28:23.781817Z","caller":"traceutil/trace.go:171","msg":"trace[1930087355] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"180.122044ms","start":"2026-06-16T10:28:23.601668Z","end":"2026-06-16T10:28:23.781791Z","steps":["trace[1930087355] 'process raft request' (duration: 179.992673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:24.241165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.09551ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:28:24.241369Z","caller":"traceutil/trace.go:171","msg":"trace[2063003924] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2750; }","duration":"341.314703ms","start":"2026-06-16T10:28:23.900037Z","end":"2026-06-16T10:28:24.241351Z","steps":["trace[2063003924] 'range keys from in-memory index tree' (duration: 341.07857ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.242131Z","caller":"traceutil/trace.go:171","msg":"trace[960028605] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"148.859417ms","start":"2026-06-16T10:28:24.093247Z","end":"2026-06-16T10:28:24.242106Z","steps":["trace[960028605] 'process raft request' (duration: 148.622943ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.326433Z","caller":"traceutil/trace.go:171","msg":"trace[139134255] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"146.777974ms","start":"2026-06-16T10:28:24.179632Z","end":"2026-06-16T10:28:24.32641Z","steps":["trace[139134255] 'process raft request' (duration: 146.305649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:24.326669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.331186ms","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-16T10:28:24.326715Z","caller":"traceutil/trace.go:171","msg":"trace[1158864965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2753; }","duration":"117.412177ms","start":"2026-06-16T10:28:24.20929Z","end":"2026-06-16T10:28:24.326703Z","steps":["trace[1158864965] 'agreement among raft nodes before linearized reading' (duration: 117.316146ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.326722Z","caller":"traceutil/trace.go:171","msg":"trace[890392316] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"146.925855ms","start":"2026-06-16T10:28:24.179743Z","end":"2026-06-16T10:28:24.326668Z","steps":["trace[890392316] 'process raft request' (duration: 146.321739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:28:24.327008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.8594ms","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-16T10:28:24.327134Z","caller":"traceutil/trace.go:171","msg":"trace[923602237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2753; }","duration":"130.052223ms","start":"2026-06-16T10:28:24.19705Z","end":"2026-06-16T10:28:24.327103Z","steps":["trace[923602237] 'agreement among raft nodes before linearized reading' (duration: 129.655909ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.468401Z","caller":"traceutil/trace.go:171","msg":"trace[980156882] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"136.403031ms","start":"2026-06-16T10:28:24.33196Z","end":"2026-06-16T10:28:24.468363Z","steps":["trace[980156882] 'process raft request' (duration: 94.106485ms)","trace[980156882] 'compare' (duration: 42.055144ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:28:24.503591Z","caller":"traceutil/trace.go:171","msg":"trace[626748231] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"171.004214ms","start":"2026-06-16T10:28:24.332477Z","end":"2026-06-16T10:28:24.503481Z","steps":["trace[626748231] 'process raft request' (duration: 170.762942ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.503523Z","caller":"traceutil/trace.go:171","msg":"trace[64350481] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"170.868153ms","start":"2026-06-16T10:28:24.332612Z","end":"2026-06-16T10:28:24.50348Z","steps":["trace[64350481] 'process raft request' (duration: 170.790122ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.503848Z","caller":"traceutil/trace.go:171","msg":"trace[1263603176] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"171.210887ms","start":"2026-06-16T10:28:24.332615Z","end":"2026-06-16T10:28:24.503826Z","steps":["trace[1263603176] 'process raft request' (duration: 170.817853ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:28:24.50387Z","caller":"traceutil/trace.go:171","msg":"trace[1484864193] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"171.174546ms","start":"2026-06-16T10:28:24.332654Z","end":"2026-06-16T10:28:24.503828Z","steps":["trace[1484864193] 'process raft request' (duration: 171.037934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.413358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.274082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T10:29:25.41343Z","caller":"traceutil/trace.go:171","msg":"trace[790086563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3070; }","duration":"586.390467ms","start":"2026-06-16T10:29:24.827023Z","end":"2026-06-16T10:29:25.413414Z","steps":["trace[790086563] 'range keys from in-memory index tree' (duration: 586.127456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.413463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:29:24.827003Z","time spent":"586.453189ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T10:29:25.41344Z","caller":"traceutil/trace.go:171","msg":"trace[1251888089] linearizableReadLoop","detail":"{readStateIndex:3194; appliedIndex:3193; }","duration":"250.755535ms","start":"2026-06-16T10:29:25.162652Z","end":"2026-06-16T10:29:25.413407Z","steps":["trace[1251888089] 'read index received' (duration: 243.710518ms)","trace[1251888089] 'applied index is now lower than readState.Index' (duration: 7.043857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:29:25.413469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.309099ms","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-16T10:29:25.413564Z","caller":"traceutil/trace.go:171","msg":"trace[1122533747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3070; }","duration":"659.410463ms","start":"2026-06-16T10:29:24.75413Z","end":"2026-06-16T10:29:25.41354Z","steps":["trace[1122533747] 'range keys from in-memory index tree' (duration: 659.071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.413634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:29:24.754068Z","time spent":"659.548638ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T10:29:25.413469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.480613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-16T10:29:25.413781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.111619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:29:25.413794Z","caller":"traceutil/trace.go:171","msg":"trace[2133090677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3070; }","duration":"585.857387ms","start":"2026-06-16T10:29:24.827921Z","end":"2026-06-16T10:29:25.413778Z","steps":["trace[2133090677] 'range keys from in-memory index tree' (duration: 585.306986ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:25.413833Z","caller":"traceutil/trace.go:171","msg":"trace[349784178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3071; }","duration":"251.207902ms","start":"2026-06-16T10:29:25.162612Z","end":"2026-06-16T10:29:25.41382Z","steps":["trace[349784178] 'agreement among raft nodes before linearized reading' (duration: 250.916032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.41384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:29:24.827899Z","time spent":"585.927739ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T10:29:25.414093Z","caller":"traceutil/trace.go:171","msg":"trace[965309300] transaction","detail":"{read_only:false; response_revision:3071; number_of_response:1; }","duration":"290.694822ms","start":"2026-06-16T10:29:25.123382Z","end":"2026-06-16T10:29:25.414077Z","steps":["trace[965309300] 'process raft request' (duration: 283.075194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.414865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.802314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-16T10:29:25.415081Z","caller":"traceutil/trace.go:171","msg":"trace[1828731789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3070; }","duration":"580.045093ms","start":"2026-06-16T10:29:24.835015Z","end":"2026-06-16T10:29:25.41506Z","steps":["trace[1828731789] 'range keys from in-memory index tree' (duration: 579.514803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.415137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:29:24.834993Z","time spent":"580.125116ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T10:29:25.415867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.696523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-16T10:29:25.415952Z","caller":"traceutil/trace.go:171","msg":"trace[1144775107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3070; }","duration":"584.802146ms","start":"2026-06-16T10:29:24.831137Z","end":"2026-06-16T10:29:25.415939Z","steps":["trace[1144775107] 'range keys from in-memory index tree' (duration: 581.717114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:29:25.415979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:29:24.83112Z","time spent":"584.851539ms","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-16T10:29:26.707144Z","caller":"traceutil/trace.go:171","msg":"trace[1251699080] transaction","detail":"{read_only:false; response_revision:3080; number_of_response:1; }","duration":"246.545069ms","start":"2026-06-16T10:29:26.460572Z","end":"2026-06-16T10:29:26.707118Z","steps":["trace[1251699080] 'process raft request' (duration: 246.049911ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:26.707569Z","caller":"traceutil/trace.go:171","msg":"trace[1933291427] linearizableReadLoop","detail":"{readStateIndex:3204; appliedIndex:3203; }","duration":"156.663337ms","start":"2026-06-16T10:29:26.550161Z","end":"2026-06-16T10:29:26.706824Z","steps":["trace[1933291427] 'read index received' (duration: 156.413338ms)","trace[1933291427] 'applied index is now lower than readState.Index' (duration: 248.849µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:29:26.707797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.578281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-16T10:29:26.707909Z","caller":"traceutil/trace.go:171","msg":"trace[2014468410] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3080; }","duration":"157.761517ms","start":"2026-06-16T10:29:26.550128Z","end":"2026-06-16T10:29:26.70789Z","steps":["trace[2014468410] 'agreement among raft nodes before linearized reading' (duration: 157.395443ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:29:27.232077Z","caller":"traceutil/trace.go:171","msg":"trace[913372663] transaction","detail":"{read_only:false; response_revision:3084; number_of_response:1; }","duration":"114.565299ms","start":"2026-06-16T10:29:27.117487Z","end":"2026-06-16T10:29:27.232052Z","steps":["trace[913372663] 'process raft request' (duration: 114.296159ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:03.389133Z","caller":"traceutil/trace.go:171","msg":"trace[1816406301] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"133.628043ms","start":"2026-06-16T10:32:03.255479Z","end":"2026-06-16T10:32:03.389107Z","steps":["trace[1816406301] 'process raft request' (duration: 133.145362ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:04.444207Z","caller":"traceutil/trace.go:171","msg":"trace[2109525860] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"168.15211ms","start":"2026-06-16T10:32:04.276029Z","end":"2026-06-16T10:32:04.444181Z","steps":["trace[2109525860] 'process raft request' (duration: 168.019917ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:04.444985Z","caller":"traceutil/trace.go:171","msg":"trace[1798294448] linearizableReadLoop","detail":"{readStateIndex:4793; appliedIndex:4793; }","duration":"166.75377ms","start":"2026-06-16T10:32:04.277803Z","end":"2026-06-16T10:32:04.444557Z","steps":["trace[1798294448] 'read index received' (duration: 166.611567ms)","trace[1798294448] 'applied index is now lower than readState.Index' (duration: 88.632µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:32:04.446009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.18514ms","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-16T10:32:04.446083Z","caller":"traceutil/trace.go:171","msg":"trace[1052275782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4609; }","duration":"168.307273ms","start":"2026-06-16T10:32:04.277756Z","end":"2026-06-16T10:32:04.446064Z","steps":["trace[1052275782] 'agreement among raft nodes before linearized reading' (duration: 167.289841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:04.447527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.661861ms","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-16T10:32:04.447574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.69261ms","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-16T10:32:04.447611Z","caller":"traceutil/trace.go:171","msg":"trace[1270038518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4609; }","duration":"169.784713ms","start":"2026-06-16T10:32:04.277814Z","end":"2026-06-16T10:32:04.447599Z","steps":["trace[1270038518] 'agreement among raft nodes before linearized reading' (duration: 169.61249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:04.447732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.785522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-8ndcq\" ","response":"range_response_count:1 size:5148"} {"level":"info","ts":"2026-06-16T10:32:04.447767Z","caller":"traceutil/trace.go:171","msg":"trace[689808017] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-8ndcq; range_end:; response_count:1; response_revision:4609; }","duration":"124.856114ms","start":"2026-06-16T10:32:04.322901Z","end":"2026-06-16T10:32:04.447757Z","steps":["trace[689808017] 'agreement among raft nodes before linearized reading' (duration: 124.772362ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:04.447649Z","caller":"traceutil/trace.go:171","msg":"trace[363438515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4609; }","duration":"168.802203ms","start":"2026-06-16T10:32:04.27883Z","end":"2026-06-16T10:32:04.447633Z","steps":["trace[363438515] 'agreement among raft nodes before linearized reading' (duration: 168.578738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:04.449473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.984449ms","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-16T10:32:04.449613Z","caller":"traceutil/trace.go:171","msg":"trace[619997715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4609; }","duration":"171.767664ms","start":"2026-06-16T10:32:04.277795Z","end":"2026-06-16T10:32:04.449563Z","steps":["trace[619997715] 'agreement among raft nodes before linearized reading' (duration: 168.632059ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:09.801419Z","caller":"traceutil/trace.go:171","msg":"trace[837003197] linearizableReadLoop","detail":"{readStateIndex:4895; appliedIndex:4894; }","duration":"251.666335ms","start":"2026-06-16T10:32:09.549735Z","end":"2026-06-16T10:32:09.801401Z","steps":["trace[837003197] 'read index received' (duration: 251.513762ms)","trace[837003197] 'applied index is now lower than readState.Index' (duration: 151.553µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:09.801602Z","caller":"traceutil/trace.go:171","msg":"trace[1760452597] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"260.365234ms","start":"2026-06-16T10:32:09.54123Z","end":"2026-06-16T10:32:09.801596Z","steps":["trace[1760452597] 'process raft request' (duration: 260.068857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:09.801793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.046995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-06-16T10:32:09.801811Z","caller":"traceutil/trace.go:171","msg":"trace[1360566567] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4710; }","duration":"252.095825ms","start":"2026-06-16T10:32:09.54971Z","end":"2026-06-16T10:32:09.801805Z","steps":["trace[1360566567] 'agreement among raft nodes before linearized reading' (duration: 252.009674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:09.801914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.08128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-16T10:32:09.80193Z","caller":"traceutil/trace.go:171","msg":"trace[492911700] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4710; }","duration":"241.107871ms","start":"2026-06-16T10:32:09.560815Z","end":"2026-06-16T10:32:09.801923Z","steps":["trace[492911700] 'agreement among raft nodes before linearized reading' (duration: 241.0668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:09.802798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.220567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-16T10:32:09.802861Z","caller":"traceutil/trace.go:171","msg":"trace[264705972] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4710; }","duration":"228.324398ms","start":"2026-06-16T10:32:09.574522Z","end":"2026-06-16T10:32:09.802846Z","steps":["trace[264705972] 'agreement among raft nodes before linearized reading' (duration: 227.505122ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.169149Z","caller":"traceutil/trace.go:171","msg":"trace[1673030404] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4895; }","duration":"338.421853ms","start":"2026-06-16T10:32:09.830707Z","end":"2026-06-16T10:32:10.169128Z","steps":["trace[1673030404] 'read index received' (duration: 322.659261ms)","trace[1673030404] 'applied index is now lower than readState.Index' (duration: 15.761532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:32:10.169305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.584156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-06-16T10:32:10.169336Z","caller":"traceutil/trace.go:171","msg":"trace[1640630311] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4711; }","duration":"338.651258ms","start":"2026-06-16T10:32:09.830675Z","end":"2026-06-16T10:32:10.169326Z","steps":["trace[1640630311] 'agreement among raft nodes before linearized reading' (duration: 338.528306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:10.16936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:32:09.830661Z","time spent":"338.693859ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1840,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-06-16T10:32:10.169336Z","caller":"traceutil/trace.go:171","msg":"trace[630018729] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"361.342381ms","start":"2026-06-16T10:32:09.807954Z","end":"2026-06-16T10:32:10.169296Z","steps":["trace[630018729] 'process raft request' (duration: 345.384865ms)","trace[630018729] 'compare' (duration: 15.432426ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:32:10.169548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:32:09.807943Z","time spent":"361.507285ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T10:32:10.662987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.824367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T10:32:10.663083Z","caller":"traceutil/trace.go:171","msg":"trace[411883180] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"256.728769ms","start":"2026-06-16T10:32:10.406333Z","end":"2026-06-16T10:32:10.663062Z","steps":["trace[411883180] 'process raft request' (duration: 155.758579ms)","trace[411883180] 'compare' (duration: 100.715824ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:10.688774Z","caller":"traceutil/trace.go:171","msg":"trace[1579680148] linearizableReadLoop","detail":"{readStateIndex:4910; appliedIndex:4908; }","duration":"216.906334ms","start":"2026-06-16T10:32:10.471835Z","end":"2026-06-16T10:32:10.688741Z","steps":["trace[1579680148] 'read index received' (duration: 90.262221ms)","trace[1579680148] 'applied index is now lower than readState.Index' (duration: 126.642433ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:10.688833Z","caller":"traceutil/trace.go:171","msg":"trace[1443844521] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"257.151797ms","start":"2026-06-16T10:32:10.43166Z","end":"2026-06-16T10:32:10.688812Z","steps":["trace[1443844521] 'process raft request' (duration: 256.947673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:10.689224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.364084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T10:32:10.689346Z","caller":"traceutil/trace.go:171","msg":"trace[610359992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4725; }","duration":"217.471836ms","start":"2026-06-16T10:32:10.471803Z","end":"2026-06-16T10:32:10.689275Z","steps":["trace[610359992] 'agreement among raft nodes before linearized reading' (duration: 217.086868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:10.717791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.317734ms","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-16T10:32:10.717849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.825693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-16T10:32:10.717871Z","caller":"traceutil/trace.go:171","msg":"trace[350982044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4727; }","duration":"242.432647ms","start":"2026-06-16T10:32:10.475421Z","end":"2026-06-16T10:32:10.717854Z","steps":["trace[350982044] 'agreement among raft nodes before linearized reading' (duration: 242.220293ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.717897Z","caller":"traceutil/trace.go:171","msg":"trace[438086525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4727; }","duration":"238.907414ms","start":"2026-06-16T10:32:10.478977Z","end":"2026-06-16T10:32:10.717884Z","steps":["trace[438086525] 'agreement among raft nodes before linearized reading' (duration: 238.748651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:10.718104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.62327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-16T10:32:10.718218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.768901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-16T10:32:10.718331Z","caller":"traceutil/trace.go:171","msg":"trace[1620932811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4727; }","duration":"238.957625ms","start":"2026-06-16T10:32:10.479355Z","end":"2026-06-16T10:32:10.718313Z","steps":["trace[1620932811] 'agreement among raft nodes before linearized reading' (duration: 238.633018ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.71816Z","caller":"traceutil/trace.go:171","msg":"trace[1500126048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4727; }","duration":"242.726933ms","start":"2026-06-16T10:32:10.475419Z","end":"2026-06-16T10:32:10.718146Z","steps":["trace[1500126048] 'agreement among raft nodes before linearized reading' (duration: 242.536489ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.718157Z","caller":"traceutil/trace.go:171","msg":"trace[1979054045] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"154.488392ms","start":"2026-06-16T10:32:10.563654Z","end":"2026-06-16T10:32:10.718143Z","steps":["trace[1979054045] 'process raft request' (duration: 153.763726ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.859925Z","caller":"traceutil/trace.go:171","msg":"trace[1147016980] linearizableReadLoop","detail":"{readStateIndex:4917; appliedIndex:4912; }","duration":"113.617687ms","start":"2026-06-16T10:32:10.746286Z","end":"2026-06-16T10:32:10.859904Z","steps":["trace[1147016980] 'read index received' (duration: 6.200936ms)","trace[1147016980] 'applied index is now lower than readState.Index' (duration: 107.415841ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:10.860032Z","caller":"traceutil/trace.go:171","msg":"trace[1087849029] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"137.843762ms","start":"2026-06-16T10:32:10.722179Z","end":"2026-06-16T10:32:10.860023Z","steps":["trace[1087849029] 'process raft request' (duration: 137.661529ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.860023Z","caller":"traceutil/trace.go:171","msg":"trace[1114301496] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"137.887063ms","start":"2026-06-16T10:32:10.722109Z","end":"2026-06-16T10:32:10.859996Z","steps":["trace[1114301496] 'process raft request' (duration: 137.697339ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.860227Z","caller":"traceutil/trace.go:171","msg":"trace[1967860035] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"137.040595ms","start":"2026-06-16T10:32:10.723177Z","end":"2026-06-16T10:32:10.860218Z","steps":["trace[1967860035] 'process raft request' (duration: 136.695028ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:10.860307Z","caller":"traceutil/trace.go:171","msg":"trace[408997316] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"138.502735ms","start":"2026-06-16T10:32:10.721795Z","end":"2026-06-16T10:32:10.860298Z","steps":["trace[408997316] 'process raft request' (duration: 137.888903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:10.860582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.275142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-06-16T10:32:10.860668Z","caller":"traceutil/trace.go:171","msg":"trace[204977100] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4732; }","duration":"114.401074ms","start":"2026-06-16T10:32:10.746246Z","end":"2026-06-16T10:32:10.860647Z","steps":["trace[204977100] 'agreement among raft nodes before linearized reading' (duration: 114.043296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:11.090848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.940034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7510"} {"level":"info","ts":"2026-06-16T10:32:11.090929Z","caller":"traceutil/trace.go:171","msg":"trace[1964657669] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4732; }","duration":"174.049916ms","start":"2026-06-16T10:32:10.916862Z","end":"2026-06-16T10:32:11.090912Z","steps":["trace[1964657669] 'range keys from in-memory index tree' (duration: 173.76272ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:13.729131Z","caller":"traceutil/trace.go:171","msg":"trace[207489080] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"260.11176ms","start":"2026-06-16T10:32:13.468994Z","end":"2026-06-16T10:32:13.729106Z","steps":["trace[207489080] 'process raft request' (duration: 260.001068ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:13.729165Z","caller":"traceutil/trace.go:171","msg":"trace[1159056086] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"277.220897ms","start":"2026-06-16T10:32:13.451914Z","end":"2026-06-16T10:32:13.729135Z","steps":["trace[1159056086] 'process raft request' (duration: 234.892478ms)","trace[1159056086] 'compare' (duration: 41.898669ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:23.663193Z","caller":"traceutil/trace.go:171","msg":"trace[117550562] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5086; }","duration":"265.887899ms","start":"2026-06-16T10:32:23.39728Z","end":"2026-06-16T10:32:23.663168Z","steps":["trace[117550562] 'read index received' (duration: 265.767326ms)","trace[117550562] 'applied index is now lower than readState.Index' (duration: 119.443µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:32:23.663291Z","caller":"traceutil/trace.go:171","msg":"trace[761127666] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"332.977358ms","start":"2026-06-16T10:32:23.330285Z","end":"2026-06-16T10:32:23.663263Z","steps":["trace[761127666] 'process raft request' (duration: 332.723093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:32:23.663418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.127823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-06-16T10:32:23.663422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T10:32:23.330263Z","time spent":"333.08844ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T10:32:23.663529Z","caller":"traceutil/trace.go:171","msg":"trace[1557945354] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4894; }","duration":"266.217285ms","start":"2026-06-16T10:32:23.397227Z","end":"2026-06-16T10:32:23.663444Z","steps":["trace[1557945354] 'agreement among raft nodes before linearized reading' (duration: 266.073072ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:32:23.669433Z","caller":"traceutil/trace.go:171","msg":"trace[829289397] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"163.740675ms","start":"2026-06-16T10:32:23.505666Z","end":"2026-06-16T10:32:23.669407Z","steps":["trace[829289397] 'process raft request' (duration: 163.548311ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:33:32.820931Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2803} {"level":"info","ts":"2026-06-16T10:33:32.900514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2803,"took":"78.262162ms","hash":987806862,"current-db-size-bytes":53719040,"current-db-size":"54 MB","current-db-size-in-use-bytes":29032448,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-16T10:33:32.900583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":987806862,"revision":2803,"compact-revision":-1} {"level":"info","ts":"2026-06-16T10:35:56.054544Z","caller":"traceutil/trace.go:171","msg":"trace[1065511834] transaction","detail":"{read_only:false; response_revision:6451; number_of_response:1; }","duration":"122.084456ms","start":"2026-06-16T10:35:55.932432Z","end":"2026-06-16T10:35:56.054516Z","steps":["trace[1065511834] 'process raft request' (duration: 121.998775ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:35:56.054662Z","caller":"traceutil/trace.go:171","msg":"trace[991682971] transaction","detail":"{read_only:false; response_revision:6450; number_of_response:1; }","duration":"184.992893ms","start":"2026-06-16T10:35:55.869642Z","end":"2026-06-16T10:35:56.054635Z","steps":["trace[991682971] 'process raft request' (duration: 120.775966ms)","trace[991682971] 'compare' (duration: 63.804361ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T10:35:56.054905Z","caller":"traceutil/trace.go:171","msg":"trace[1933317053] linearizableReadLoop","detail":"{readStateIndex:6693; appliedIndex:6692; }","duration":"124.27629ms","start":"2026-06-16T10:35:55.930465Z","end":"2026-06-16T10:35:56.054742Z","steps":["trace[1933317053] 'read index received' (duration: 59.963052ms)","trace[1933317053] 'applied index is now lower than readState.Index' (duration: 64.311678ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:35:56.055183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.702196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-16T10:35:56.055273Z","caller":"traceutil/trace.go:171","msg":"trace[1159620219] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:6452; }","duration":"124.847197ms","start":"2026-06-16T10:35:55.930409Z","end":"2026-06-16T10:35:56.055256Z","steps":["trace[1159620219] 'agreement among raft nodes before linearized reading' (duration: 124.600654ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:36:27.646418Z","caller":"traceutil/trace.go:171","msg":"trace[1484258344] transaction","detail":"{read_only:false; response_revision:6671; number_of_response:1; }","duration":"135.056714ms","start":"2026-06-16T10:36:27.511341Z","end":"2026-06-16T10:36:27.646398Z","steps":["trace[1484258344] 'process raft request' (duration: 134.921342ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:38:32.826548Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5473} {"level":"info","ts":"2026-06-16T10:38:32.958509Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5473,"took":"130.727548ms","hash":4278471911,"current-db-size-bytes":53719040,"current-db-size":"54 MB","current-db-size-in-use-bytes":18481152,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-16T10:38:32.958583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4278471911,"revision":5473,"compact-revision":2803} {"level":"info","ts":"2026-06-16T10:38:51.306931Z","caller":"traceutil/trace.go:171","msg":"trace[122291665] linearizableReadLoop","detail":"{readStateIndex:7706; appliedIndex:7705; }","duration":"146.989193ms","start":"2026-06-16T10:38:51.15991Z","end":"2026-06-16T10:38:51.306899Z","steps":["trace[122291665] 'read index received' (duration: 98.8761ms)","trace[122291665] 'applied index is now lower than readState.Index' (duration: 48.110112ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T10:38:51.307139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.21714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T10:38:51.307249Z","caller":"traceutil/trace.go:171","msg":"trace[746863799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7425; }","duration":"147.353704ms","start":"2026-06-16T10:38:51.159814Z","end":"2026-06-16T10:38:51.307168Z","steps":["trace[746863799] 'agreement among raft nodes before linearized reading' (duration: 147.22057ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T10:38:51.307312Z","caller":"traceutil/trace.go:171","msg":"trace[1888401299] transaction","detail":"{read_only:false; response_revision:7424; number_of_response:1; }","duration":"124.745503ms","start":"2026-06-16T10:38:51.182455Z","end":"2026-06-16T10:38:51.307201Z","steps":["trace[1888401299] 'process raft request' (duration: 124.34088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:38:51.307589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.247163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/cert-manager-webhook-ca\" ","response":"range_response_count:1 size:2164"} {"level":"info","ts":"2026-06-16T10:38:51.307664Z","caller":"traceutil/trace.go:171","msg":"trace[688854060] range","detail":"{range_begin:/registry/secrets/cert-manager/cert-manager-webhook-ca; range_end:; response_count:1; response_revision:7425; }","duration":"128.343968ms","start":"2026-06-16T10:38:51.179301Z","end":"2026-06-16T10:38:51.307645Z","steps":["trace[688854060] 'agreement among raft nodes before linearized reading' (duration: 128.178682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:38:51.307863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.771499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/default/\" range_end:\"/registry/services/specs/default0\" limit:500 ","response":"range_response_count:1 size:704"} {"level":"info","ts":"2026-06-16T10:38:51.307901Z","caller":"traceutil/trace.go:171","msg":"trace[311743358] range","detail":"{range_begin:/registry/services/specs/default/; range_end:/registry/services/specs/default0; response_count:1; response_revision:7425; }","duration":"113.8267ms","start":"2026-06-16T10:38:51.194063Z","end":"2026-06-16T10:38:51.30789Z","steps":["trace[311743358] 'agreement among raft nodes before linearized reading' (duration: 113.730127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T10:38:51.307993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.111186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/cert-manager-selfsigned-ca\" ","response":"range_response_count:1 size:2479"} {"level":"info","ts":"2026-06-16T10:38:51.308039Z","caller":"traceutil/trace.go:171","msg":"trace[810057380] range","detail":"{range_begin:/registry/secrets/cert-manager/cert-manager-selfsigned-ca; range_end:; response_count:1; response_revision:7425; }","duration":"125.169318ms","start":"2026-06-16T10:38:51.182858Z","end":"2026-06-16T10:38:51.308027Z","steps":["trace[810057380] 'agreement among raft nodes before linearized reading' (duration: 125.018453ms)"],"step_count":1}