{"level":"warn","ts":"2026-06-08T03:28:19.958884Z","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-08T03:28:19.958981Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-08T03:28:19.959058Z","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-08T03:28:19.959075Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-08T03:28:19.9591Z","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-08T03:28:19.960029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-06-08T03:28:19.960138Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-08T03:28:19.964258Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.848735ms"} {"level":"info","ts":"2026-06-08T03:28:19.97672Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-06-08T03:28:19.976814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T03:28:19.976845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-06-08T03:28:19.97686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T03:28:19.976883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-06-08T03:28:19.976942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-06-08T03:28:19.990369Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T03:28:19.99255Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T03:28:19.993792Z","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-08T03:28:19.996971Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T03:28:19.997372Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T03:28:19.997597Z","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-08T03:28:19.997665Z","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-08T03:28:19.997679Z","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-08T03:28:19.998337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-06-08T03:28:19.998444Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-08T03:28:20.00232Z","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-08T03:28:20.002443Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-08T03:28:20.002489Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-08T03:28:20.002672Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T03:28:20.002732Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T03:28:20.177533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T03:28:20.17766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T03:28:20.177703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-06-08T03:28:20.177737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-06-08T03:28:20.177759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-08T03:28:20.177783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-06-08T03:28:20.177806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-08T03:28:20.181855Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:28:20.183872Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T03:28:20.184031Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T03:28:20.185692Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:28:20.185805Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:28:20.185855Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:28:20.18609Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T03:28:20.187087Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T03:28:20.187576Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T03:28:20.187632Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T03:28:20.188235Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-06-08T03:28:25.073901Z","caller":"traceutil/trace.go:171","msg":"trace[104130832] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"112.658239ms","start":"2026-06-08T03:28:24.961228Z","end":"2026-06-08T03:28:25.073886Z","steps":["trace[104130832] 'process raft request' (duration: 112.577559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:28:26.549805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.715641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:28:26.549982Z","caller":"traceutil/trace.go:171","msg":"trace[131285080] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:332; }","duration":"335.748289ms","start":"2026-06-08T03:28:26.21421Z","end":"2026-06-08T03:28:26.549958Z","steps":["trace[131285080] 'read index received' (duration: 70.958463ms)","trace[131285080] 'applied index is now lower than readState.Index' (duration: 264.787066ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:28:26.550097Z","caller":"traceutil/trace.go:171","msg":"trace[1489739861] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"339.347726ms","start":"2026-06-08T03:28:26.210734Z","end":"2026-06-08T03:28:26.550082Z","steps":["trace[1489739861] 'process raft request' (duration: 74.45867ms)","trace[1489739861] 'compare' (duration: 263.410741ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:28:26.550173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:28:26.210716Z","time spent":"339.420337ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T03:28:26.550487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.220168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-06-08T03:28:26.550606Z","caller":"traceutil/trace.go:171","msg":"trace[786994034] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:319; }","duration":"336.410906ms","start":"2026-06-08T03:28:26.214167Z","end":"2026-06-08T03:28:26.550578Z","steps":["trace[786994034] 'agreement among raft nodes before linearized reading' (duration: 336.088597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:28:26.550618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.223178ms","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-08T03:28:26.550672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:28:26.214155Z","time spent":"336.504456ms","remote":"127.0.0.1:38756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3490,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-06-08T03:28:26.550714Z","caller":"traceutil/trace.go:171","msg":"trace[1714456348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:319; }","duration":"178.378918ms","start":"2026-06-08T03:28:26.37231Z","end":"2026-06-08T03:28:26.550689Z","steps":["trace[1714456348] 'agreement among raft nodes before linearized reading' (duration: 177.90555ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:28:26.838953Z","caller":"traceutil/trace.go:171","msg":"trace[838556758] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"122.086913ms","start":"2026-06-08T03:28:26.716838Z","end":"2026-06-08T03:28:26.838925Z","steps":["trace[838556758] 'process raft request' (duration: 77.558949ms)","trace[838556758] 'compare' (duration: 44.262576ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:28:31.955845Z","caller":"traceutil/trace.go:171","msg":"trace[1336632598] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"193.060981ms","start":"2026-06-08T03:28:31.762759Z","end":"2026-06-08T03:28:31.95582Z","steps":["trace[1336632598] 'process raft request' (duration: 192.845922ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:28:32.155614Z","caller":"traceutil/trace.go:171","msg":"trace[1895118518] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"392.741528ms","start":"2026-06-08T03:28:31.762845Z","end":"2026-06-08T03:28:32.155586Z","steps":["trace[1895118518] 'process raft request' (duration: 392.571539ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:28:32.155809Z","caller":"traceutil/trace.go:171","msg":"trace[1809770936] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"307.783225ms","start":"2026-06-08T03:28:31.847994Z","end":"2026-06-08T03:28:32.155778Z","steps":["trace[1809770936] 'process raft request' (duration: 307.553136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:28:32.156224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:28:31.847967Z","time spent":"307.934395ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:28:32.156455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:28:31.762825Z","time spent":"392.908648ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:28:32.36194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.454451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T03:28:32.362038Z","caller":"traceutil/trace.go:171","msg":"trace[1631356150] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:402; }","duration":"161.632591ms","start":"2026-06-08T03:28:32.200383Z","end":"2026-06-08T03:28:32.362016Z","steps":["trace[1631356150] 'range keys from in-memory index tree' (duration: 161.282602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:28:32.648048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.100149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:28:32.648201Z","caller":"traceutil/trace.go:171","msg":"trace[2133634488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:403; }","duration":"156.324919ms","start":"2026-06-08T03:28:32.491856Z","end":"2026-06-08T03:28:32.648181Z","steps":["trace[2133634488] 'range keys from in-memory index tree' (duration: 155.990609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.310309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.219283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:29:00.310467Z","caller":"traceutil/trace.go:171","msg":"trace[363453800] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"222.135339ms","start":"2026-06-08T03:29:00.08828Z","end":"2026-06-08T03:29:00.310416Z","steps":["trace[363453800] 'read index received' (duration: 42.611226ms)","trace[363453800] 'applied index is now lower than readState.Index' (duration: 179.522773ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:29:00.310609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.319918ms","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-08T03:29:00.310543Z","caller":"traceutil/trace.go:171","msg":"trace[640613404] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"241.74331ms","start":"2026-06-08T03:29:00.068718Z","end":"2026-06-08T03:29:00.310462Z","steps":["trace[640613404] 'process raft request' (duration: 62.268048ms)","trace[640613404] 'compare' (duration: 179.086624ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:29:00.310662Z","caller":"traceutil/trace.go:171","msg":"trace[970888609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"222.405898ms","start":"2026-06-08T03:29:00.088241Z","end":"2026-06-08T03:29:00.310647Z","steps":["trace[970888609] 'agreement among raft nodes before linearized reading' (duration: 222.307378ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:29:00.324539Z","caller":"traceutil/trace.go:171","msg":"trace[741868460] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"159.91915ms","start":"2026-06-08T03:29:00.164585Z","end":"2026-06-08T03:29:00.324504Z","steps":["trace[741868460] 'process raft request' (duration: 158.903673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.324766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.679296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:29:00.324793Z","caller":"traceutil/trace.go:171","msg":"trace[130148414] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:621; }","duration":"210.739726ms","start":"2026-06-08T03:29:00.114044Z","end":"2026-06-08T03:29:00.324784Z","steps":["trace[130148414] 'agreement among raft nodes before linearized reading' (duration: 210.679277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.32505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.258695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-7m9st\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-06-08T03:29:00.32507Z","caller":"traceutil/trace.go:171","msg":"trace[945424290] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-7m9st; range_end:; response_count:1; response_revision:621; }","duration":"121.296514ms","start":"2026-06-08T03:29:00.203767Z","end":"2026-06-08T03:29:00.325064Z","steps":["trace[945424290] 'agreement among raft nodes before linearized reading' (duration: 121.220435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.325577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.198212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-06-08T03:29:00.325598Z","caller":"traceutil/trace.go:171","msg":"trace[396976653] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:621; }","duration":"237.232102ms","start":"2026-06-08T03:29:00.088359Z","end":"2026-06-08T03:29:00.325592Z","steps":["trace[396976653] 'agreement among raft nodes before linearized reading' (duration: 237.150802ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:29:00.951526Z","caller":"traceutil/trace.go:171","msg":"trace[1354307927] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"358.379457ms","start":"2026-06-08T03:29:00.593103Z","end":"2026-06-08T03:29:00.951482Z","steps":["trace[1354307927] 'read index received' (duration: 277.649544ms)","trace[1354307927] 'applied index is now lower than readState.Index' (duration: 80.728693ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:29:00.951626Z","caller":"traceutil/trace.go:171","msg":"trace[1454524753] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"382.830787ms","start":"2026-06-08T03:29:00.568757Z","end":"2026-06-08T03:29:00.951587Z","steps":["trace[1454524753] 'process raft request' (duration: 302.039344ms)","trace[1454524753] 'compare' (duration: 80.584644ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:29:00.951828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.71316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-08T03:29:00.951833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:00.568743Z","time spent":"382.978817ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:29:00.951875Z","caller":"traceutil/trace.go:171","msg":"trace[972070673] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"356.76662ms","start":"2026-06-08T03:29:00.595097Z","end":"2026-06-08T03:29:00.951863Z","steps":["trace[972070673] 'agreement among raft nodes before linearized reading' (duration: 356.68894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.951913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:00.595078Z","time spent":"356.83003ms","remote":"127.0.0.1:38826","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-08T03:29:00.952115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.925813ms","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-08T03:29:00.95214Z","caller":"traceutil/trace.go:171","msg":"trace[46314851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"121.977583ms","start":"2026-06-08T03:29:00.830157Z","end":"2026-06-08T03:29:00.952134Z","steps":["trace[46314851] 'agreement among raft nodes before linearized reading' (duration: 121.911554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.952217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.326697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:29:00.952241Z","caller":"traceutil/trace.go:171","msg":"trace[509908466] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:639; }","duration":"239.348927ms","start":"2026-06-08T03:29:00.712885Z","end":"2026-06-08T03:29:00.952234Z","steps":["trace[509908466] 'agreement among raft nodes before linearized reading' (duration: 239.319257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.952327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.338998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:29:00.952347Z","caller":"traceutil/trace.go:171","msg":"trace[360327492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"350.375938ms","start":"2026-06-08T03:29:00.601967Z","end":"2026-06-08T03:29:00.952343Z","steps":["trace[360327492] 'agreement among raft nodes before linearized reading' (duration: 350.347788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.952362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:00.601953Z","time spent":"350.406198ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T03:29:00.95265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.522055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-06-08T03:29:00.952729Z","caller":"traceutil/trace.go:171","msg":"trace[54525206] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:639; }","duration":"359.618145ms","start":"2026-06-08T03:29:00.593088Z","end":"2026-06-08T03:29:00.952706Z","steps":["trace[54525206] 'agreement among raft nodes before linearized reading' (duration: 358.666267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:00.952906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:00.593038Z","time spent":"359.850873ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570129,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-06-08T03:29:06.931651Z","caller":"traceutil/trace.go:171","msg":"trace[376525398] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:722; }","duration":"440.357538ms","start":"2026-06-08T03:29:06.491265Z","end":"2026-06-08T03:29:06.931623Z","steps":["trace[376525398] 'read index received' (duration: 364.914975ms)","trace[376525398] 'applied index is now lower than readState.Index' (duration: 75.441243ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:29:06.931701Z","caller":"traceutil/trace.go:171","msg":"trace[762240089] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"484.984984ms","start":"2026-06-08T03:29:06.44666Z","end":"2026-06-08T03:29:06.931645Z","steps":["trace[762240089] 'process raft request' (duration: 409.60785ms)","trace[762240089] 'compare' (duration: 75.229295ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:29:06.93181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.519648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:29:06.931844Z","caller":"traceutil/trace.go:171","msg":"trace[1207350895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"440.601778ms","start":"2026-06-08T03:29:06.491231Z","end":"2026-06-08T03:29:06.931833Z","steps":["trace[1207350895] 'agreement among raft nodes before linearized reading' (duration: 440.525788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:06.931842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:06.446653Z","time spent":"485.115914ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:29:06.931887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:06.49122Z","time spent":"440.659777ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T03:29:08.04615Z","caller":"traceutil/trace.go:171","msg":"trace[356296263] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"270.287452ms","start":"2026-06-08T03:29:07.775837Z","end":"2026-06-08T03:29:08.046125Z","steps":["trace[356296263] 'process raft request' (duration: 270.142642ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:29:09.352763Z","caller":"traceutil/trace.go:171","msg":"trace[463016057] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"317.767269ms","start":"2026-06-08T03:29:09.034969Z","end":"2026-06-08T03:29:09.352737Z","steps":["trace[463016057] 'read index received' (duration: 317.628199ms)","trace[463016057] 'applied index is now lower than readState.Index' (duration: 137.32µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:29:09.353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.015518ms","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-08T03:29:09.353045Z","caller":"traceutil/trace.go:171","msg":"trace[367549119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:705; }","duration":"318.121468ms","start":"2026-06-08T03:29:09.034912Z","end":"2026-06-08T03:29:09.353034Z","steps":["trace[367549119] 'agreement among raft nodes before linearized reading' (duration: 317.969819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:09.353079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:09.034884Z","time spent":"318.187618ms","remote":"127.0.0.1:38826","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-08T03:29:09.353067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.031401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T03:29:09.353134Z","caller":"traceutil/trace.go:171","msg":"trace[142774172] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:705; }","duration":"317.147201ms","start":"2026-06-08T03:29:09.03597Z","end":"2026-06-08T03:29:09.353117Z","steps":["trace[142774172] 'agreement among raft nodes before linearized reading' (duration: 316.989131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:09.353192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:09.035939Z","time spent":"317.241181ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T03:29:09.352882Z","caller":"traceutil/trace.go:171","msg":"trace[523823133] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"412.479091ms","start":"2026-06-08T03:29:08.940341Z","end":"2026-06-08T03:29:09.35282Z","steps":["trace[523823133] 'process raft request' (duration: 412.233771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:09.353944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:08.940322Z","time spent":"413.229509ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:29:09.506154Z","caller":"traceutil/trace.go:171","msg":"trace[1327263068] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"148.476389ms","start":"2026-06-08T03:29:09.357646Z","end":"2026-06-08T03:29:09.506122Z","steps":["trace[1327263068] 'process raft request' (duration: 148.260509ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:29:09.525581Z","caller":"traceutil/trace.go:171","msg":"trace[1918133397] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"167.045595ms","start":"2026-06-08T03:29:09.358519Z","end":"2026-06-08T03:29:09.525564Z","steps":["trace[1918133397] 'process raft request' (duration: 166.668376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:24.579321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.16385ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:29:24.57944Z","caller":"traceutil/trace.go:171","msg":"trace[1770603627] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"260.349165ms","start":"2026-06-08T03:29:24.319068Z","end":"2026-06-08T03:29:24.579417Z","steps":["trace[1770603627] 'read index received' (duration: 40.936624ms)","trace[1770603627] 'applied index is now lower than readState.Index' (duration: 219.410221ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:29:24.579563Z","caller":"traceutil/trace.go:171","msg":"trace[401260080] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"449.400946ms","start":"2026-06-08T03:29:24.130144Z","end":"2026-06-08T03:29:24.579545Z","steps":["trace[401260080] 'process raft request' (duration: 229.86258ms)","trace[401260080] 'compare' (duration: 218.969603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:29:24.579652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:29:24.130117Z","time spent":"449.485479ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:29:24.57984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.760641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwkp2\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-08T03:29:24.581171Z","caller":"traceutil/trace.go:171","msg":"trace[1243478538] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwkp2; range_end:; response_count:1; response_revision:816; }","duration":"262.116125ms","start":"2026-06-08T03:29:24.31901Z","end":"2026-06-08T03:29:24.581126Z","steps":["trace[1243478538] 'agreement among raft nodes before linearized reading' (duration: 260.650598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:58.363307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.974234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:29:58.363414Z","caller":"traceutil/trace.go:171","msg":"trace[1364910309] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1229; }","duration":"118.156428ms","start":"2026-06-08T03:29:58.245234Z","end":"2026-06-08T03:29:58.363391Z","steps":["trace[1364910309] 'count revisions from in-memory index tree' (duration: 117.80892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:29:58.363446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.633953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwkp2\" ","response":"range_response_count:1 size:4126"} {"level":"info","ts":"2026-06-08T03:29:58.363727Z","caller":"traceutil/trace.go:171","msg":"trace[1403149253] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwkp2; range_end:; response_count:1; response_revision:1229; }","duration":"242.962972ms","start":"2026-06-08T03:29:58.120743Z","end":"2026-06-08T03:29:58.363706Z","steps":["trace[1403149253] 'range keys from in-memory index tree' (duration: 242.466159ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:29:58.512066Z","caller":"traceutil/trace.go:171","msg":"trace[1835424418] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"146.437001ms","start":"2026-06-08T03:29:58.365594Z","end":"2026-06-08T03:29:58.512031Z","steps":["trace[1835424418] 'process raft request' (duration: 146.248115ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:30:34.164178Z","caller":"traceutil/trace.go:171","msg":"trace[1971417632] transaction","detail":"{read_only:false; response_revision:1723; number_of_response:1; }","duration":"103.492284ms","start":"2026-06-08T03:30:34.060654Z","end":"2026-06-08T03:30:34.164146Z","steps":["trace[1971417632] 'process raft request' (duration: 96.284294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.51205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.209448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:30:48.512152Z","caller":"traceutil/trace.go:171","msg":"trace[318221699] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"567.661253ms","start":"2026-06-08T03:30:47.944474Z","end":"2026-06-08T03:30:48.512135Z","steps":["trace[318221699] 'process raft request' (duration: 122.264052ms)","trace[318221699] 'compare' (duration: 444.855873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:30:48.5122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.94445Z","time spent":"567.729133ms","remote":"127.0.0.1:38730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:30:48.52545Z","caller":"traceutil/trace.go:171","msg":"trace[1929559716] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"580.721581ms","start":"2026-06-08T03:30:47.944691Z","end":"2026-06-08T03:30:48.525412Z","steps":["trace[1929559716] 'process raft request' (duration: 580.380387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.525712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.944664Z","time spent":"580.894214ms","remote":"127.0.0.1:38828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:30:48.526071Z","caller":"traceutil/trace.go:171","msg":"trace[518949345] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"581.205377ms","start":"2026-06-08T03:30:47.944846Z","end":"2026-06-08T03:30:48.526051Z","steps":["trace[518949345] 'process raft request' (duration: 580.485228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.526163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.944822Z","time spent":"581.29694ms","remote":"127.0.0.1:38730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:30:48.526271Z","caller":"traceutil/trace.go:171","msg":"trace[87197026] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1989; }","duration":"558.163906ms","start":"2026-06-08T03:30:47.96809Z","end":"2026-06-08T03:30:48.526253Z","steps":["trace[87197026] 'read index received' (duration: 98.740875ms)","trace[87197026] 'applied index is now lower than readState.Index' (duration: 459.422091ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:30:48.526303Z","caller":"traceutil/trace.go:171","msg":"trace[1289742087] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"513.789325ms","start":"2026-06-08T03:30:48.012505Z","end":"2026-06-08T03:30:48.526294Z","steps":["trace[1289742087] 'process raft request' (duration: 513.701794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.526346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.012475Z","time spent":"513.847886ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:30:48.526333Z","caller":"traceutil/trace.go:171","msg":"trace[604818521] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"580.55974ms","start":"2026-06-08T03:30:47.945726Z","end":"2026-06-08T03:30:48.526286Z","steps":["trace[604818521] 'process raft request' (duration: 580.411788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.526389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.293628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:30:48.526253Z","caller":"traceutil/trace.go:171","msg":"trace[214121578] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"581.34952ms","start":"2026-06-08T03:30:47.94487Z","end":"2026-06-08T03:30:48.526219Z","steps":["trace[214121578] 'process raft request' (duration: 581.124886ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:30:48.526445Z","caller":"traceutil/trace.go:171","msg":"trace[745393569] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1916; }","duration":"558.358069ms","start":"2026-06-08T03:30:47.968072Z","end":"2026-06-08T03:30:48.52643Z","steps":["trace[745393569] 'agreement among raft nodes before linearized reading' (duration: 558.246407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.526485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.968054Z","time spent":"558.421689ms","remote":"127.0.0.1:38730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":15,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-08T03:30:48.52651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.945717Z","time spent":"580.700612ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:30:48.526648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:47.94484Z","time spent":"581.703015ms","remote":"127.0.0.1:38828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:30:48.552509Z","caller":"traceutil/trace.go:171","msg":"trace[1051623795] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"470.928779ms","start":"2026-06-08T03:30:48.081543Z","end":"2026-06-08T03:30:48.552472Z","steps":["trace[1051623795] 'process raft request' (duration: 470.707727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.552563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.677733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T03:30:48.552633Z","caller":"traceutil/trace.go:171","msg":"trace[1916608836] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1917; }","duration":"452.805495ms","start":"2026-06-08T03:30:48.099805Z","end":"2026-06-08T03:30:48.552611Z","steps":["trace[1916608836] 'agreement among raft nodes before linearized reading' (duration: 452.587542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.552662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.081519Z","time spent":"471.071472ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:30:48.552681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.099783Z","time spent":"452.889307ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T03:30:48.552841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.469272ms","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-08T03:30:48.552877Z","caller":"traceutil/trace.go:171","msg":"trace[1931167951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1917; }","duration":"445.522282ms","start":"2026-06-08T03:30:48.107345Z","end":"2026-06-08T03:30:48.552867Z","steps":["trace[1931167951] 'agreement among raft nodes before linearized reading' (duration: 445.431601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:48.552913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.107331Z","time spent":"445.575643ms","remote":"127.0.0.1:38826","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-08T03:30:48.796418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.717926ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:30:48.796562Z","caller":"traceutil/trace.go:171","msg":"trace[755616062] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"238.260626ms","start":"2026-06-08T03:30:48.558277Z","end":"2026-06-08T03:30:48.796538Z","steps":["trace[755616062] 'process raft request' (duration: 123.325847ms)","trace[755616062] 'compare' (duration: 114.597034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:30:49.059793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.249101ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-08T03:30:49.06004Z","caller":"traceutil/trace.go:171","msg":"trace[497606459] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1997; }","duration":"320.143069ms","start":"2026-06-08T03:30:48.73986Z","end":"2026-06-08T03:30:49.060003Z","steps":["trace[497606459] 'read index received' (duration: 64.091µs)","trace[497606459] 'applied index is now lower than readState.Index' (duration: 320.075448ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:30:49.060178Z","caller":"traceutil/trace.go:171","msg":"trace[1521320213] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"113.37991ms","start":"2026-06-08T03:30:48.946773Z","end":"2026-06-08T03:30:49.060153Z","steps":["trace[1521320213] 'process raft request' (duration: 113.172638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:49.060375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.032681ms","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-08T03:30:49.060428Z","caller":"traceutil/trace.go:171","msg":"trace[1650946127] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1920; }","duration":"318.123102ms","start":"2026-06-08T03:30:48.742289Z","end":"2026-06-08T03:30:49.060412Z","steps":["trace[1650946127] 'agreement among raft nodes before linearized reading' (duration: 317.882879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:49.060468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.742282Z","time spent":"318.174323ms","remote":"127.0.0.1:50634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-08T03:30:49.06042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.556334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1b0eefc-0945-47ec-a2cc-239740eb3f44\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-08T03:30:49.060592Z","caller":"traceutil/trace.go:171","msg":"trace[1316943066] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1b0eefc-0945-47ec-a2cc-239740eb3f44; range_end:; response_count:1; response_revision:1920; }","duration":"320.714926ms","start":"2026-06-08T03:30:48.739793Z","end":"2026-06-08T03:30:49.060508Z","steps":["trace[1316943066] 'agreement among raft nodes before linearized reading' (duration: 320.308862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:30:49.060748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:30:48.739767Z","time spent":"320.916149ms","remote":"127.0.0.1:38756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1b0eefc-0945-47ec-a2cc-239740eb3f44\" "} {"level":"info","ts":"2026-06-08T03:31:01.597296Z","caller":"traceutil/trace.go:171","msg":"trace[287938212] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"463.799129ms","start":"2026-06-08T03:31:01.133467Z","end":"2026-06-08T03:31:01.597266Z","steps":["trace[287938212] 'process raft request' (duration: 443.119898ms)","trace[287938212] 'compare' (duration: 19.213165ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:01.597442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:01.133445Z","time spent":"463.91382ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:31:01.597551Z","caller":"traceutil/trace.go:171","msg":"trace[867403987] linearizableReadLoop","detail":"{readStateIndex:2104; appliedIndex:2102; }","duration":"453.20003ms","start":"2026-06-08T03:31:01.144326Z","end":"2026-06-08T03:31:01.597526Z","steps":["trace[867403987] 'read index received' (duration: 432.283907ms)","trace[867403987] 'applied index is now lower than readState.Index' (duration: 20.914663ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:31:01.59769Z","caller":"traceutil/trace.go:171","msg":"trace[506228486] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"464.044043ms","start":"2026-06-08T03:31:01.133635Z","end":"2026-06-08T03:31:01.597679Z","steps":["trace[506228486] 'process raft request' (duration: 463.754489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:01.597802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.565862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"warn","ts":"2026-06-08T03:31:01.597809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:01.133595Z","time spent":"464.120843ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:31:01.597832Z","caller":"traceutil/trace.go:171","msg":"trace[1268222525] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2021; }","duration":"172.638822ms","start":"2026-06-08T03:31:01.425186Z","end":"2026-06-08T03:31:01.597825Z","steps":["trace[1268222525] 'agreement among raft nodes before linearized reading' (duration: 172.499911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:01.597947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.049558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:31:01.597965Z","caller":"traceutil/trace.go:171","msg":"trace[1362715006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2021; }","duration":"106.088358ms","start":"2026-06-08T03:31:01.491873Z","end":"2026-06-08T03:31:01.597961Z","steps":["trace[1362715006] 'agreement among raft nodes before linearized reading' (duration: 106.056227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:01.597934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.592366ms","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-08T03:31:01.598017Z","caller":"traceutil/trace.go:171","msg":"trace[398671255] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2021; }","duration":"453.713927ms","start":"2026-06-08T03:31:01.14428Z","end":"2026-06-08T03:31:01.597994Z","steps":["trace[398671255] 'agreement among raft nodes before linearized reading' (duration: 453.488445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:01.598068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:01.144262Z","time spent":"453.796968ms","remote":"127.0.0.1:50634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-08T03:31:17.823918Z","caller":"traceutil/trace.go:171","msg":"trace[1331343367] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"146.503097ms","start":"2026-06-08T03:31:17.677393Z","end":"2026-06-08T03:31:17.823896Z","steps":["trace[1331343367] 'read index received' (duration: 146.341405ms)","trace[1331343367] 'applied index is now lower than readState.Index' (duration: 160.982µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:17.824114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.698398ms","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-08T03:31:17.824199Z","caller":"traceutil/trace.go:171","msg":"trace[529135135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2126; }","duration":"146.814709ms","start":"2026-06-08T03:31:17.677375Z","end":"2026-06-08T03:31:17.824189Z","steps":["trace[529135135] 'agreement among raft nodes before linearized reading' (duration: 146.646078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:17.82431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.570942ms","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-08T03:31:17.824414Z","caller":"traceutil/trace.go:171","msg":"trace[1512852390] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2126; }","duration":"117.691823ms","start":"2026-06-08T03:31:17.706694Z","end":"2026-06-08T03:31:17.824386Z","steps":["trace[1512852390] 'agreement among raft nodes before linearized reading' (duration: 117.39629ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:31:17.82409Z","caller":"traceutil/trace.go:171","msg":"trace[1264666081] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"150.385803ms","start":"2026-06-08T03:31:17.673565Z","end":"2026-06-08T03:31:17.823951Z","steps":["trace[1264666081] 'process raft request' (duration: 150.211682ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:31:23.581598Z","caller":"traceutil/trace.go:171","msg":"trace[311847915] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"203.048171ms","start":"2026-06-08T03:31:23.378515Z","end":"2026-06-08T03:31:23.581563Z","steps":["trace[311847915] 'process raft request' (duration: 147.98645ms)","trace[311847915] 'compare' (duration: 54.909769ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:24.335989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.13545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:31:24.336102Z","caller":"traceutil/trace.go:171","msg":"trace[1057968916] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2247; }","duration":"185.955642ms","start":"2026-06-08T03:31:24.15013Z","end":"2026-06-08T03:31:24.336076Z","steps":["trace[1057968916] 'read index received' (duration: 13.568731ms)","trace[1057968916] 'applied index is now lower than readState.Index' (duration: 172.376171ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:31:24.336359Z","caller":"traceutil/trace.go:171","msg":"trace[1682233084] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"248.224361ms","start":"2026-06-08T03:31:24.088075Z","end":"2026-06-08T03:31:24.336299Z","steps":["trace[1682233084] 'process raft request' (duration: 75.680208ms)","trace[1682233084] 'compare' (duration: 171.866538ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:24.336433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.305045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:31:24.336491Z","caller":"traceutil/trace.go:171","msg":"trace[709155517] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2160; }","duration":"186.386226ms","start":"2026-06-08T03:31:24.150073Z","end":"2026-06-08T03:31:24.336459Z","steps":["trace[709155517] 'agreement among raft nodes before linearized reading' (duration: 186.200934ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:31:24.900992Z","caller":"traceutil/trace.go:171","msg":"trace[1306259813] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"195.242573ms","start":"2026-06-08T03:31:24.705711Z","end":"2026-06-08T03:31:24.900954Z","steps":["trace[1306259813] 'read index received' (duration: 194.8391ms)","trace[1306259813] 'applied index is now lower than readState.Index' (duration: 401.633µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:24.901268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.512796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:31:24.901318Z","caller":"traceutil/trace.go:171","msg":"trace[2093674376] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2161; }","duration":"195.658318ms","start":"2026-06-08T03:31:24.705648Z","end":"2026-06-08T03:31:24.901306Z","steps":["trace[2093674376] 'agreement among raft nodes before linearized reading' (duration: 195.528036ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:31:24.901413Z","caller":"traceutil/trace.go:171","msg":"trace[1226482368] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"211.423837ms","start":"2026-06-08T03:31:24.68964Z","end":"2026-06-08T03:31:24.901064Z","steps":["trace[1226482368] 'process raft request' (duration: 211.054504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:24.901596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.128625ms","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-08T03:31:24.901691Z","caller":"traceutil/trace.go:171","msg":"trace[1446890455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2161; }","duration":"117.298026ms","start":"2026-06-08T03:31:24.784371Z","end":"2026-06-08T03:31:24.901669Z","steps":["trace[1446890455] 'agreement among raft nodes before linearized reading' (duration: 117.035344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:24.901601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.639779ms","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-08T03:31:24.901834Z","caller":"traceutil/trace.go:171","msg":"trace[1919505359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2161; }","duration":"194.941621ms","start":"2026-06-08T03:31:24.706871Z","end":"2026-06-08T03:31:24.901813Z","steps":["trace[1919505359] 'agreement among raft nodes before linearized reading' (duration: 194.522788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:25.266876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.762657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:31:25.267636Z","caller":"traceutil/trace.go:171","msg":"trace[1166632903] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"361.259887ms","start":"2026-06-08T03:31:24.906353Z","end":"2026-06-08T03:31:25.267613Z","steps":["trace[1166632903] 'process raft request' (duration: 192.637063ms)","trace[1166632903] 'compare' (duration: 167.459544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:31:25.267809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:24.906333Z","time spent":"361.434588ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:31:25.270868Z","caller":"traceutil/trace.go:171","msg":"trace[1763710700] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2249; }","duration":"355.015901ms","start":"2026-06-08T03:31:24.915826Z","end":"2026-06-08T03:31:25.270842Z","steps":["trace[1763710700] 'read index received' (duration: 182.395672ms)","trace[1763710700] 'applied index is now lower than readState.Index' (duration: 172.618659ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:31:25.270922Z","caller":"traceutil/trace.go:171","msg":"trace[1904848954] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"363.675938ms","start":"2026-06-08T03:31:24.90723Z","end":"2026-06-08T03:31:25.270906Z","steps":["trace[1904848954] 'process raft request' (duration: 363.463196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:25.271125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.302084ms","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-08T03:31:25.271181Z","caller":"traceutil/trace.go:171","msg":"trace[433239934] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"355.380976ms","start":"2026-06-08T03:31:24.915788Z","end":"2026-06-08T03:31:25.271169Z","steps":["trace[433239934] 'agreement among raft nodes before linearized reading' (duration: 355.167444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:25.271205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:24.915777Z","time spent":"355.422206ms","remote":"127.0.0.1:50634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-08T03:31:25.271211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:31:24.907197Z","time spent":"363.86374ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:31:25.288354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.294877ms","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-08T03:31:25.288408Z","caller":"traceutil/trace.go:171","msg":"trace[1349549627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"283.382618ms","start":"2026-06-08T03:31:25.005014Z","end":"2026-06-08T03:31:25.288396Z","steps":["trace[1349549627] 'agreement among raft nodes before linearized reading' (duration: 283.230997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:31:25.288538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.030319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T03:31:25.288592Z","caller":"traceutil/trace.go:171","msg":"trace[937191665] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2164; }","duration":"168.128351ms","start":"2026-06-08T03:31:25.120451Z","end":"2026-06-08T03:31:25.288579Z","steps":["trace[937191665] 'agreement among raft nodes before linearized reading' (duration: 167.868748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:32:30.944138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.212325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:32:30.944226Z","caller":"traceutil/trace.go:171","msg":"trace[1273129539] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2621; }","duration":"100.355196ms","start":"2026-06-08T03:32:30.843852Z","end":"2026-06-08T03:32:30.944207Z","steps":["trace[1273129539] 'count revisions from in-memory index tree' (duration: 99.901513ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:32:31.653257Z","caller":"traceutil/trace.go:171","msg":"trace[642138617] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"132.340203ms","start":"2026-06-08T03:32:31.520883Z","end":"2026-06-08T03:32:31.653223Z","steps":["trace[642138617] 'process raft request' (duration: 132.132711ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:38.319868Z","caller":"traceutil/trace.go:171","msg":"trace[517915027] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"181.362101ms","start":"2026-06-08T03:36:38.138469Z","end":"2026-06-08T03:36:38.319831Z","steps":["trace[517915027] 'process raft request' (duration: 112.552551ms)","trace[517915027] 'compare' (duration: 68.492896ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:36:38.320204Z","caller":"traceutil/trace.go:171","msg":"trace[652501106] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"177.618796ms","start":"2026-06-08T03:36:38.142567Z","end":"2026-06-08T03:36:38.320186Z","steps":["trace[652501106] 'process raft request' (duration: 177.417353ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:40.444563Z","caller":"traceutil/trace.go:171","msg":"trace[935085754] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"169.037786ms","start":"2026-06-08T03:36:40.275496Z","end":"2026-06-08T03:36:40.444534Z","steps":["trace[935085754] 'process raft request' (duration: 168.769661ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:40.446563Z","caller":"traceutil/trace.go:171","msg":"trace[51671280] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"121.008318ms","start":"2026-06-08T03:36:40.325517Z","end":"2026-06-08T03:36:40.446526Z","steps":["trace[51671280] 'process raft request' (duration: 120.770025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.391597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.673903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:36:46.39175Z","caller":"traceutil/trace.go:171","msg":"trace[98310281] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4741; }","duration":"205.905936ms","start":"2026-06-08T03:36:46.185822Z","end":"2026-06-08T03:36:46.391728Z","steps":["trace[98310281] 'count revisions from in-memory index tree' (duration: 205.569072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.392036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.740917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:36:46.392121Z","caller":"traceutil/trace.go:171","msg":"trace[44904672] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4741; }","duration":"264.887701ms","start":"2026-06-08T03:36:46.127215Z","end":"2026-06-08T03:36:46.392102Z","steps":["trace[44904672] 'range keys from in-memory index tree' (duration: 264.637696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.393133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.105836ms","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-08T03:36:46.393201Z","caller":"traceutil/trace.go:171","msg":"trace[2071429966] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4741; }","duration":"165.208197ms","start":"2026-06-08T03:36:46.227979Z","end":"2026-06-08T03:36:46.393188Z","steps":["trace[2071429966] 'range keys from in-memory index tree' (duration: 163.821568ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:46.626596Z","caller":"traceutil/trace.go:171","msg":"trace[727863410] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"231.001216ms","start":"2026-06-08T03:36:46.395575Z","end":"2026-06-08T03:36:46.626576Z","steps":["trace[727863410] 'process raft request' (duration: 230.867224ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:46.626608Z","caller":"traceutil/trace.go:171","msg":"trace[1500038167] linearizableReadLoop","detail":"{readStateIndex:4931; appliedIndex:4931; }","duration":"230.245255ms","start":"2026-06-08T03:36:46.396338Z","end":"2026-06-08T03:36:46.626583Z","steps":["trace[1500038167] 'read index received' (duration: 230.237125ms)","trace[1500038167] 'applied index is now lower than readState.Index' (duration: 7.03µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:36:46.626799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.441388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:36:46.626824Z","caller":"traceutil/trace.go:171","msg":"trace[724934018] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4742; }","duration":"230.496579ms","start":"2026-06-08T03:36:46.39632Z","end":"2026-06-08T03:36:46.626816Z","steps":["trace[724934018] 'agreement among raft nodes before linearized reading' (duration: 230.364348ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:46.639594Z","caller":"traceutil/trace.go:171","msg":"trace[1365488739] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"117.641544ms","start":"2026-06-08T03:36:46.521941Z","end":"2026-06-08T03:36:46.639582Z","steps":["trace[1365488739] 'process raft request' (duration: 117.073696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.639798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.814016ms","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-08T03:36:46.639849Z","caller":"traceutil/trace.go:171","msg":"trace[1378535954] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4744; }","duration":"218.915908ms","start":"2026-06-08T03:36:46.420919Z","end":"2026-06-08T03:36:46.639835Z","steps":["trace[1378535954] 'agreement among raft nodes before linearized reading' (duration: 218.663395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.640083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.634174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:36:46.640115Z","caller":"traceutil/trace.go:171","msg":"trace[455470186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4744; }","duration":"150.688206ms","start":"2026-06-08T03:36:46.489416Z","end":"2026-06-08T03:36:46.640105Z","steps":["trace[455470186] 'agreement among raft nodes before linearized reading' (duration: 150.618685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:46.640342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.839009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16085"} {"level":"info","ts":"2026-06-08T03:36:46.640372Z","caller":"traceutil/trace.go:171","msg":"trace[2083227972] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4744; }","duration":"163.897579ms","start":"2026-06-08T03:36:46.476465Z","end":"2026-06-08T03:36:46.640363Z","steps":["trace[2083227972] 'agreement among raft nodes before linearized reading' (duration: 163.786838ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:46.943874Z","caller":"traceutil/trace.go:171","msg":"trace[270218067] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4934; }","duration":"278.752283ms","start":"2026-06-08T03:36:46.665095Z","end":"2026-06-08T03:36:46.943848Z","steps":["trace[270218067] 'read index received' (duration: 278.479078ms)","trace[270218067] 'applied index is now lower than readState.Index' (duration: 271.835µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:36:46.94411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.987586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-08T03:36:46.944154Z","caller":"traceutil/trace.go:171","msg":"trace[261505960] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4746; }","duration":"279.061727ms","start":"2026-06-08T03:36:46.665079Z","end":"2026-06-08T03:36:46.944141Z","steps":["trace[261505960] 'agreement among raft nodes before linearized reading' (duration: 278.885134ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:46.944103Z","caller":"traceutil/trace.go:171","msg":"trace[1964017503] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"288.322497ms","start":"2026-06-08T03:36:46.65575Z","end":"2026-06-08T03:36:46.944072Z","steps":["trace[1964017503] 'process raft request' (duration: 287.90287ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.11489Z","caller":"traceutil/trace.go:171","msg":"trace[1500670363] linearizableReadLoop","detail":"{readStateIndex:4936; appliedIndex:4935; }","duration":"161.234825ms","start":"2026-06-08T03:36:46.953624Z","end":"2026-06-08T03:36:47.114858Z","steps":["trace[1500670363] 'read index received' (duration: 133.760613ms)","trace[1500670363] 'applied index is now lower than readState.Index' (duration: 27.466252ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:36:47.115007Z","caller":"traceutil/trace.go:171","msg":"trace[2111121001] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"161.657763ms","start":"2026-06-08T03:36:46.953291Z","end":"2026-06-08T03:36:47.114949Z","steps":["trace[2111121001] 'process raft request' (duration: 134.016358ms)","trace[2111121001] 'compare' (duration: 27.26779ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:36:47.115179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.52879ms","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-08T03:36:47.115227Z","caller":"traceutil/trace.go:171","msg":"trace[2073991158] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4747; }","duration":"161.639281ms","start":"2026-06-08T03:36:46.953577Z","end":"2026-06-08T03:36:47.115216Z","steps":["trace[2073991158] 'agreement among raft nodes before linearized reading' (duration: 161.423838ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.139554Z","caller":"traceutil/trace.go:171","msg":"trace[1995418104] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"185.735466ms","start":"2026-06-08T03:36:46.953789Z","end":"2026-06-08T03:36:47.139524Z","steps":["trace[1995418104] 'process raft request' (duration: 185.469982ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.13991Z","caller":"traceutil/trace.go:171","msg":"trace[1016088101] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"186.035581ms","start":"2026-06-08T03:36:46.95384Z","end":"2026-06-08T03:36:47.139875Z","steps":["trace[1016088101] 'process raft request' (duration: 185.612975ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.140695Z","caller":"traceutil/trace.go:171","msg":"trace[1663205299] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"186.7395ms","start":"2026-06-08T03:36:46.953929Z","end":"2026-06-08T03:36:47.140668Z","steps":["trace[1663205299] 'process raft request' (duration: 185.788607ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.140935Z","caller":"traceutil/trace.go:171","msg":"trace[331353675] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"178.88805ms","start":"2026-06-08T03:36:46.962037Z","end":"2026-06-08T03:36:47.140925Z","steps":["trace[331353675] 'process raft request' (duration: 178.297663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.141127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.858966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-08T03:36:47.141527Z","caller":"traceutil/trace.go:171","msg":"trace[501418764] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4752; }","duration":"185.309931ms","start":"2026-06-08T03:36:46.956204Z","end":"2026-06-08T03:36:47.141514Z","steps":["trace[501418764] 'agreement among raft nodes before linearized reading' (duration: 184.757173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.141239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.932224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-08T03:36:47.141715Z","caller":"traceutil/trace.go:171","msg":"trace[1965798547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4752; }","duration":"172.426261ms","start":"2026-06-08T03:36:46.969279Z","end":"2026-06-08T03:36:47.141705Z","steps":["trace[1965798547] 'agreement among raft nodes before linearized reading' (duration: 171.896374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.141323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.088622ms","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-08T03:36:47.141922Z","caller":"traceutil/trace.go:171","msg":"trace[772582020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4752; }","duration":"166.713931ms","start":"2026-06-08T03:36:46.975173Z","end":"2026-06-08T03:36:47.141887Z","steps":["trace[772582020] 'agreement among raft nodes before linearized reading' (duration: 165.972641ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.485086Z","caller":"traceutil/trace.go:171","msg":"trace[65825625] linearizableReadLoop","detail":"{readStateIndex:4942; appliedIndex:4941; }","duration":"344.573384ms","start":"2026-06-08T03:36:47.140487Z","end":"2026-06-08T03:36:47.485061Z","steps":["trace[65825625] 'read index received' (duration: 331.470963ms)","trace[65825625] 'applied index is now lower than readState.Index' (duration: 13.101151ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:36:47.485419Z","caller":"traceutil/trace.go:171","msg":"trace[126009476] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"365.075449ms","start":"2026-06-08T03:36:47.120324Z","end":"2026-06-08T03:36:47.485399Z","steps":["trace[126009476] 'process raft request' (duration: 351.607502ms)","trace[126009476] 'compare' (duration: 13.016251ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:36:47.485551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.120283Z","time spent":"365.187041ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:36:47.485754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.392186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:36:47.485801Z","caller":"traceutil/trace.go:171","msg":"trace[455754774] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:4753; }","duration":"368.437837ms","start":"2026-06-08T03:36:47.117349Z","end":"2026-06-08T03:36:47.485787Z","steps":["trace[455754774] 'agreement among raft nodes before linearized reading' (duration: 368.368406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.485838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.117309Z","time spent":"368.519678ms","remote":"127.0.0.1:39848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"info","ts":"2026-06-08T03:36:47.529918Z","caller":"traceutil/trace.go:171","msg":"trace[727861905] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"381.942725ms","start":"2026-06-08T03:36:47.147947Z","end":"2026-06-08T03:36:47.52989Z","steps":["trace[727861905] 'process raft request' (duration: 381.785883ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.529936Z","caller":"traceutil/trace.go:171","msg":"trace[1656424900] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"381.887625ms","start":"2026-06-08T03:36:47.14803Z","end":"2026-06-08T03:36:47.529918Z","steps":["trace[1656424900] 'process raft request' (duration: 381.812324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.530055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.148004Z","time spent":"381.982235ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:36:47.530055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.147929Z","time spent":"382.055016ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:36:47.530238Z","caller":"traceutil/trace.go:171","msg":"trace[1407600515] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"380.680137ms","start":"2026-06-08T03:36:47.14954Z","end":"2026-06-08T03:36:47.53022Z","steps":["trace[1407600515] 'process raft request' (duration: 380.332992ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.530319Z","caller":"traceutil/trace.go:171","msg":"trace[1102087436] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"379.742084ms","start":"2026-06-08T03:36:47.150568Z","end":"2026-06-08T03:36:47.53031Z","steps":["trace[1102087436] 'process raft request' (duration: 379.514921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.530367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.150545Z","time spent":"379.796905ms","remote":"127.0.0.1:38828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1454,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:36:47.530369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.149524Z","time spent":"380.777158ms","remote":"127.0.0.1:38730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1282,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:36:47.530565Z","caller":"traceutil/trace.go:171","msg":"trace[30842886] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"379.831166ms","start":"2026-06-08T03:36:47.150723Z","end":"2026-06-08T03:36:47.530555Z","steps":["trace[30842886] 'process raft request' (duration: 379.45045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.530682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.150718Z","time spent":"379.877577ms","remote":"127.0.0.1:38730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:36:47.531051Z","caller":"traceutil/trace.go:171","msg":"trace[1417199281] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"379.402629ms","start":"2026-06-08T03:36:47.151625Z","end":"2026-06-08T03:36:47.531027Z","steps":["trace[1417199281] 'process raft request' (duration: 378.878632ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:47.531213Z","caller":"traceutil/trace.go:171","msg":"trace[262328708] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"202.104942ms","start":"2026-06-08T03:36:47.329091Z","end":"2026-06-08T03:36:47.531196Z","steps":["trace[262328708] 'process raft request' (duration: 201.851149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.531379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.550127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-08T03:36:47.531407Z","caller":"traceutil/trace.go:171","msg":"trace[2087873716] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4760; }","duration":"383.76191ms","start":"2026-06-08T03:36:47.147638Z","end":"2026-06-08T03:36:47.5314Z","steps":["trace[2087873716] 'agreement among raft nodes before linearized reading' (duration: 383.660249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:47.531429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.147614Z","time spent":"383.810191ms","remote":"127.0.0.1:38656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":1366,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" "} {"level":"warn","ts":"2026-06-08T03:36:47.531334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:36:47.151606Z","time spent":"379.569361ms","remote":"127.0.0.1:38828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1868,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:36:49.645271Z","caller":"traceutil/trace.go:171","msg":"trace[1605002101] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"101.931968ms","start":"2026-06-08T03:36:49.543318Z","end":"2026-06-08T03:36:49.64525Z","steps":["trace[1605002101] 'process raft request' (duration: 101.865097ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:49.645476Z","caller":"traceutil/trace.go:171","msg":"trace[200601424] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"102.279792ms","start":"2026-06-08T03:36:49.543162Z","end":"2026-06-08T03:36:49.645442Z","steps":["trace[200601424] 'process raft request' (duration: 75.721456ms)","trace[200601424] 'compare' (duration: 26.190572ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:36:50.855496Z","caller":"traceutil/trace.go:171","msg":"trace[1614967742] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"125.078191ms","start":"2026-06-08T03:36:50.730391Z","end":"2026-06-08T03:36:50.855469Z","steps":["trace[1614967742] 'process raft request' (duration: 124.926409ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.598106Z","caller":"traceutil/trace.go:171","msg":"trace[796029498] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"117.022345ms","start":"2026-06-08T03:37:00.481063Z","end":"2026-06-08T03:37:00.598085Z","steps":["trace[796029498] 'process raft request' (duration: 116.871453ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.867475Z","caller":"traceutil/trace.go:171","msg":"trace[1242725655] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"204.16431ms","start":"2026-06-08T03:37:00.663284Z","end":"2026-06-08T03:37:00.867449Z","steps":["trace[1242725655] 'process raft request' (duration: 203.971768ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.867554Z","caller":"traceutil/trace.go:171","msg":"trace[1844269805] linearizableReadLoop","detail":"{readStateIndex:5115; appliedIndex:5115; }","duration":"203.969107ms","start":"2026-06-08T03:37:00.663558Z","end":"2026-06-08T03:37:00.867527Z","steps":["trace[1844269805] 'read index received' (duration: 203.960087ms)","trace[1844269805] 'applied index is now lower than readState.Index' (duration: 7.06µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:37:00.867835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.255201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-08T03:37:00.867871Z","caller":"traceutil/trace.go:171","msg":"trace[1068722850] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4920; }","duration":"204.328741ms","start":"2026-06-08T03:37:00.663531Z","end":"2026-06-08T03:37:00.86786Z","steps":["trace[1068722850] 'agreement among raft nodes before linearized reading' (duration: 204.120249ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.872168Z","caller":"traceutil/trace.go:171","msg":"trace[681994393] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"117.54332ms","start":"2026-06-08T03:37:00.754613Z","end":"2026-06-08T03:37:00.872157Z","steps":["trace[681994393] 'process raft request' (duration: 117.295916ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.872033Z","caller":"traceutil/trace.go:171","msg":"trace[603383863] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"207.801568ms","start":"2026-06-08T03:37:00.664216Z","end":"2026-06-08T03:37:00.872018Z","steps":["trace[603383863] 'process raft request' (duration: 207.540755ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:00.872793Z","caller":"traceutil/trace.go:171","msg":"trace[1435776177] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"109.785967ms","start":"2026-06-08T03:37:00.762994Z","end":"2026-06-08T03:37:00.87278Z","steps":["trace[1435776177] 'process raft request' (duration: 109.105727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:00.874576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.436735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-08T03:37:00.874648Z","caller":"traceutil/trace.go:171","msg":"trace[692385248] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4923; }","duration":"127.282769ms","start":"2026-06-08T03:37:00.747347Z","end":"2026-06-08T03:37:00.87463Z","steps":["trace[692385248] 'agreement among raft nodes before linearized reading' (duration: 125.187142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:42.701373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.049831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-08T03:37:42.701476Z","caller":"traceutil/trace.go:171","msg":"trace[592826964] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5279; }","duration":"162.183452ms","start":"2026-06-08T03:37:42.53927Z","end":"2026-06-08T03:37:42.701454Z","steps":["trace[592826964] 'range keys from in-memory index tree' (duration: 161.87523ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:56.137615Z","caller":"traceutil/trace.go:171","msg":"trace[1425458421] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"261.44331ms","start":"2026-06-08T03:37:55.876145Z","end":"2026-06-08T03:37:56.137589Z","steps":["trace[1425458421] 'process raft request' (duration: 261.282949ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:56.342334Z","caller":"traceutil/trace.go:171","msg":"trace[2089269259] linearizableReadLoop","detail":"{readStateIndex:5582; appliedIndex:5580; }","duration":"335.533465ms","start":"2026-06-08T03:37:56.006778Z","end":"2026-06-08T03:37:56.342311Z","steps":["trace[2089269259] 'read index received' (duration: 130.606457ms)","trace[2089269259] 'applied index is now lower than readState.Index' (duration: 204.925638ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:37:56.342475Z","caller":"traceutil/trace.go:171","msg":"trace[764337695] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"388.255515ms","start":"2026-06-08T03:37:55.954209Z","end":"2026-06-08T03:37:56.342464Z","steps":["trace[764337695] 'process raft request' (duration: 363.60532ms)","trace[764337695] 'compare' (duration: 24.072218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:37:56.342603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:37:55.954181Z","time spent":"388.326136ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:37:56.342781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.285331ms","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-08T03:37:56.34289Z","caller":"traceutil/trace.go:171","msg":"trace[1073840734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5374; }","duration":"205.445112ms","start":"2026-06-08T03:37:56.137418Z","end":"2026-06-08T03:37:56.342863Z","steps":["trace[1073840734] 'agreement among raft nodes before linearized reading' (duration: 205.17024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:56.343028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.136612ms","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-08T03:37:56.343074Z","caller":"traceutil/trace.go:171","msg":"trace[1941928812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5374; }","duration":"182.208073ms","start":"2026-06-08T03:37:56.160856Z","end":"2026-06-08T03:37:56.343064Z","steps":["trace[1941928812] 'agreement among raft nodes before linearized reading' (duration: 182.043242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:56.343212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.272036ms","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-08T03:37:56.343253Z","caller":"traceutil/trace.go:171","msg":"trace[1398657176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5374; }","duration":"184.346946ms","start":"2026-06-08T03:37:56.158896Z","end":"2026-06-08T03:37:56.343243Z","steps":["trace[1398657176] 'agreement among raft nodes before linearized reading' (duration: 184.216015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:56.343282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.510545ms","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-08T03:37:56.343321Z","caller":"traceutil/trace.go:171","msg":"trace[79107287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5374; }","duration":"336.579155ms","start":"2026-06-08T03:37:56.006732Z","end":"2026-06-08T03:37:56.343312Z","steps":["trace[79107287] 'agreement among raft nodes before linearized reading' (duration: 336.482144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:56.343353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:37:56.006696Z","time spent":"336.649716ms","remote":"127.0.0.1:38826","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":"warn","ts":"2026-06-08T03:37:56.343553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.643588ms","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-08T03:37:56.343788Z","caller":"traceutil/trace.go:171","msg":"trace[590711049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5374; }","duration":"200.914473ms","start":"2026-06-08T03:37:56.142861Z","end":"2026-06-08T03:37:56.343775Z","steps":["trace[590711049] 'agreement among raft nodes before linearized reading' (duration: 200.607439ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:38:20.360858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2890} {"level":"info","ts":"2026-06-08T03:38:20.446014Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2890,"took":"83.925261ms","hash":3053806238,"current-db-size-bytes":52580352,"current-db-size":"53 MB","current-db-size-in-use-bytes":29048832,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-08T03:38:20.446089Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3053806238,"revision":2890,"compact-revision":-1} {"level":"info","ts":"2026-06-08T03:40:53.418696Z","caller":"traceutil/trace.go:171","msg":"trace[2087992746] transaction","detail":"{read_only:false; response_revision:6588; number_of_response:1; }","duration":"111.646595ms","start":"2026-06-08T03:40:53.307023Z","end":"2026-06-08T03:40:53.418669Z","steps":["trace[2087992746] 'process raft request' (duration: 111.342733ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:40:53.419197Z","caller":"traceutil/trace.go:171","msg":"trace[1411346907] transaction","detail":"{read_only:false; response_revision:6589; number_of_response:1; }","duration":"111.832356ms","start":"2026-06-08T03:40:53.307337Z","end":"2026-06-08T03:40:53.419169Z","steps":["trace[1411346907] 'process raft request' (duration: 111.241201ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:40:53.419935Z","caller":"traceutil/trace.go:171","msg":"trace[1530157402] transaction","detail":"{read_only:false; response_revision:6591; number_of_response:1; }","duration":"112.024337ms","start":"2026-06-08T03:40:53.307884Z","end":"2026-06-08T03:40:53.419909Z","steps":["trace[1530157402] 'process raft request' (duration: 111.919066ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:40:53.420247Z","caller":"traceutil/trace.go:171","msg":"trace[136203058] transaction","detail":"{read_only:false; response_revision:6590; number_of_response:1; }","duration":"112.845364ms","start":"2026-06-08T03:40:53.307362Z","end":"2026-06-08T03:40:53.420208Z","steps":["trace[136203058] 'process raft request' (duration: 111.598214ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:40:53.423665Z","caller":"traceutil/trace.go:171","msg":"trace[2073168479] transaction","detail":"{read_only:false; response_revision:6592; number_of_response:1; }","duration":"104.199622ms","start":"2026-06-08T03:40:53.319445Z","end":"2026-06-08T03:40:53.423645Z","steps":["trace[2073168479] 'process raft request' (duration: 104.093951ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:41:12.16023Z","caller":"traceutil/trace.go:171","msg":"trace[1962116605] transaction","detail":"{read_only:false; response_revision:6737; number_of_response:1; }","duration":"117.432326ms","start":"2026-06-08T03:41:12.042674Z","end":"2026-06-08T03:41:12.160107Z","steps":["trace[1962116605] 'process raft request' (duration: 117.251354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:41:12.350309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.059497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:41:12.350546Z","caller":"traceutil/trace.go:171","msg":"trace[1963793727] transaction","detail":"{read_only:false; response_revision:6738; number_of_response:1; }","duration":"307.621775ms","start":"2026-06-08T03:41:12.042892Z","end":"2026-06-08T03:41:12.350514Z","steps":["trace[1963793727] 'process raft request' (duration: 197.052694ms)","trace[1963793727] 'compare' (duration: 109.969046ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:41:12.35074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:41:12.042877Z","time spent":"307.776967ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T03:43:20.367058Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5559} {"level":"info","ts":"2026-06-08T03:43:20.496779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5559,"took":"128.177342ms","hash":984336274,"current-db-size-bytes":52580352,"current-db-size":"53 MB","current-db-size-in-use-bytes":18276352,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-08T03:43:20.496833Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":984336274,"revision":5559,"compact-revision":2890}