{"level":"warn","ts":"2026-07-26T10:23:43.007055Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T10:23:43.0074Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.222: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://162.253.55.222:2380","--initial-cluster=instance=https://162.253.55.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.222: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-07-26T10:23:43.00748Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T10:23:43.007494Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T10:23:43.007516Z","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-07-26T10:23:43.008162Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"]} {"level":"info","ts":"2026-07-26T10:23:43.00825Z","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":16,"max-cpu-available":16,"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://162.253.55.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.222: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-07-26T10:23:43.011488Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.032267ms"} {"level":"info","ts":"2026-07-26T10:23:43.016798Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5a9e84e0e0a90b63","cluster-id":"c7ddd50204a2b828"} {"level":"info","ts":"2026-07-26T10:23:43.016873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=()"} {"level":"info","ts":"2026-07-26T10:23:43.016904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 0"} {"level":"info","ts":"2026-07-26T10:23:43.016921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5a9e84e0e0a90b63 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-26T10:23:43.016929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 1"} {"level":"info","ts":"2026-07-26T10:23:43.016968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"warn","ts":"2026-07-26T10:23:43.021922Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-26T10:23:43.023339Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-26T10:23:43.024498Z","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-07-26T10:23:43.027131Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5a9e84e0e0a90b63","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-26T10:23:43.027365Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5a9e84e0e0a90b63","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-26T10:23:43.028193Z","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-07-26T10:23:43.028415Z","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-07-26T10:23:43.028465Z","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-07-26T10:23:43.029676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"info","ts":"2026-07-26T10:23:43.029779Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","added-peer-id":"5a9e84e0e0a90b63","added-peer-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T10:23:43.032827Z","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-07-26T10:23:43.033029Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T10:23:43.03309Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T10:23:43.033095Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5a9e84e0e0a90b63","initial-advertise-peer-urls":["https://162.253.55.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-26T10:23:43.033138Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-26T10:23:43.917548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 is starting a new election at term 1"} {"level":"info","ts":"2026-07-26T10:23:43.917614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-26T10:23:43.917652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgPreVoteResp from 5a9e84e0e0a90b63 at term 1"} {"level":"info","ts":"2026-07-26T10:23:43.917671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became candidate at term 2"} {"level":"info","ts":"2026-07-26T10:23:43.917682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgVoteResp from 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T10:23:43.917706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became leader at term 2"} {"level":"info","ts":"2026-07-26T10:23:43.917721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a9e84e0e0a90b63 elected leader 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T10:23:43.918761Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5a9e84e0e0a90b63","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.222:2379]}","request-path":"/0/members/5a9e84e0e0a90b63/attributes","cluster-id":"c7ddd50204a2b828","publish-timeout":"7s"} {"level":"info","ts":"2026-07-26T10:23:43.918805Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T10:23:43.918912Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T10:23:43.918921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T10:23:43.919143Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-26T10:23:43.919182Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-26T10:23:43.920073Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T10:23:43.920152Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T10:23:43.920175Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T10:23:43.922265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-26T10:23:43.922501Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.222:2379"} {"level":"warn","ts":"2026-07-26T10:24:28.764591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.018315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-26T10:24:28.764718Z","caller":"traceutil/trace.go:171","msg":"trace[1718862961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"205.198857ms","start":"2026-07-26T10:24:28.5595Z","end":"2026-07-26T10:24:28.764699Z","steps":["trace[1718862961] 'range keys from in-memory index tree' (duration: 204.840573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:24:28.764591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.938019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:24:28.764927Z","caller":"traceutil/trace.go:171","msg":"trace[1903624936] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"295.498555ms","start":"2026-07-26T10:24:28.469416Z","end":"2026-07-26T10:24:28.764915Z","steps":["trace[1903624936] 'range keys from in-memory index tree' (duration: 294.807498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:24:29.218478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.634957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:24:29.218556Z","caller":"traceutil/trace.go:171","msg":"trace[2034302382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"289.729968ms","start":"2026-07-26T10:24:28.928808Z","end":"2026-07-26T10:24:29.218538Z","steps":["trace[2034302382] 'range keys from in-memory index tree' (duration: 289.547606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:24:29.219073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.451747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-swwpk\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-26T10:24:29.21916Z","caller":"traceutil/trace.go:171","msg":"trace[1253133951] range","detail":"{range_begin:/registry/pods/kube-system/cilium-swwpk; range_end:; response_count:1; response_revision:626; }","duration":"208.592779ms","start":"2026-07-26T10:24:29.010547Z","end":"2026-07-26T10:24:29.219139Z","steps":["trace[1253133951] 'range keys from in-memory index tree' (duration: 207.657719ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:24:45.040697Z","caller":"traceutil/trace.go:171","msg":"trace[2003854425] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"111.361122ms","start":"2026-07-26T10:24:44.929304Z","end":"2026-07-26T10:24:45.040665Z","steps":["trace[2003854425] 'read index received' (duration: 111.10198ms)","trace[2003854425] 'applied index is now lower than readState.Index' (duration: 258.172µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:24:45.040792Z","caller":"traceutil/trace.go:171","msg":"trace[1945332591] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"165.88331ms","start":"2026-07-26T10:24:44.874869Z","end":"2026-07-26T10:24:45.040752Z","steps":["trace[1945332591] 'process raft request' (duration: 165.600487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:24:45.04088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.539054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:24:45.040924Z","caller":"traceutil/trace.go:171","msg":"trace[2054357651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"111.631695ms","start":"2026-07-26T10:24:44.929281Z","end":"2026-07-26T10:24:45.040912Z","steps":["trace[2054357651] 'agreement among raft nodes before linearized reading' (duration: 111.530534ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:08.004782Z","caller":"traceutil/trace.go:171","msg":"trace[1239761190] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"197.062625ms","start":"2026-07-26T10:25:07.807681Z","end":"2026-07-26T10:25:08.004743Z","steps":["trace[1239761190] 'process raft request' (duration: 196.755821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:08.267484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.790586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:25:08.267585Z","caller":"traceutil/trace.go:171","msg":"trace[533835782] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1263; }","duration":"146.977878ms","start":"2026-07-26T10:25:08.120588Z","end":"2026-07-26T10:25:08.267566Z","steps":["trace[533835782] 'count revisions from in-memory index tree' (duration: 146.683325ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:08.361592Z","caller":"traceutil/trace.go:171","msg":"trace[1207806702] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"102.322741ms","start":"2026-07-26T10:25:08.25924Z","end":"2026-07-26T10:25:08.361563Z","steps":["trace[1207806702] 'process raft request' (duration: 102.141769ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:08.424902Z","caller":"traceutil/trace.go:171","msg":"trace[1118302704] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"150.721426ms","start":"2026-07-26T10:25:08.274156Z","end":"2026-07-26T10:25:08.424878Z","steps":["trace[1118302704] 'process raft request' (duration: 150.627025ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:08.424953Z","caller":"traceutil/trace.go:171","msg":"trace[1726557629] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"153.717027ms","start":"2026-07-26T10:25:08.271212Z","end":"2026-07-26T10:25:08.424929Z","steps":["trace[1726557629] 'process raft request' (duration: 146.654494ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530317Z","caller":"traceutil/trace.go:171","msg":"trace[2065302441] transaction","detail":"{read_only:false; response_revision:1512; number_of_response:1; }","duration":"156.252331ms","start":"2026-07-26T10:25:21.37403Z","end":"2026-07-26T10:25:21.530283Z","steps":["trace[2065302441] 'process raft request' (duration: 140.505452ms)","trace[2065302441] 'compare' (duration: 15.474507ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:21.530365Z","caller":"traceutil/trace.go:171","msg":"trace[2024347069] transaction","detail":"{read_only:false; response_revision:1513; number_of_response:1; }","duration":"155.527114ms","start":"2026-07-26T10:25:21.374808Z","end":"2026-07-26T10:25:21.530335Z","steps":["trace[2024347069] 'process raft request' (duration: 155.401443ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530503Z","caller":"traceutil/trace.go:171","msg":"trace[332382721] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"154.039078ms","start":"2026-07-26T10:25:21.376455Z","end":"2026-07-26T10:25:21.530494Z","steps":["trace[332382721] 'process raft request' (duration: 153.877317ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530559Z","caller":"traceutil/trace.go:171","msg":"trace[2138784210] transaction","detail":"{read_only:false; response_revision:1517; number_of_response:1; }","duration":"152.108808ms","start":"2026-07-26T10:25:21.378444Z","end":"2026-07-26T10:25:21.530553Z","steps":["trace[2138784210] 'process raft request' (duration: 151.998017ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530534Z","caller":"traceutil/trace.go:171","msg":"trace[1851317594] transaction","detail":"{read_only:false; response_revision:1516; number_of_response:1; }","duration":"152.716726ms","start":"2026-07-26T10:25:21.377778Z","end":"2026-07-26T10:25:21.530494Z","steps":["trace[1851317594] 'process raft request' (duration: 152.628015ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.53066Z","caller":"traceutil/trace.go:171","msg":"trace[1964838430] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"150.483843ms","start":"2026-07-26T10:25:21.380156Z","end":"2026-07-26T10:25:21.53064Z","steps":["trace[1964838430] 'process raft request' (duration: 150.381842ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530663Z","caller":"traceutil/trace.go:171","msg":"trace[927145623] transaction","detail":"{read_only:false; response_revision:1518; number_of_response:1; }","duration":"151.866356ms","start":"2026-07-26T10:25:21.378759Z","end":"2026-07-26T10:25:21.530625Z","steps":["trace[927145623] 'process raft request' (duration: 151.731194ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530721Z","caller":"traceutil/trace.go:171","msg":"trace[1791150120] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"148.290951ms","start":"2026-07-26T10:25:21.382416Z","end":"2026-07-26T10:25:21.530707Z","steps":["trace[1791150120] 'process raft request' (duration: 148.168949ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.53077Z","caller":"traceutil/trace.go:171","msg":"trace[1423923999] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"147.700474ms","start":"2026-07-26T10:25:21.383058Z","end":"2026-07-26T10:25:21.530758Z","steps":["trace[1423923999] 'process raft request' (duration: 147.569503ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530851Z","caller":"traceutil/trace.go:171","msg":"trace[556479411] transaction","detail":"{read_only:false; response_revision:1522; number_of_response:1; }","duration":"145.669964ms","start":"2026-07-26T10:25:21.385173Z","end":"2026-07-26T10:25:21.530843Z","steps":["trace[556479411] 'process raft request' (duration: 145.530253ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530891Z","caller":"traceutil/trace.go:171","msg":"trace[2053132689] transaction","detail":"{read_only:false; response_revision:1514; number_of_response:1; }","duration":"154.664444ms","start":"2026-07-26T10:25:21.375778Z","end":"2026-07-26T10:25:21.530443Z","steps":["trace[2053132689] 'process raft request' (duration: 154.496232ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.530914Z","caller":"traceutil/trace.go:171","msg":"trace[1790311728] transaction","detail":"{read_only:false; response_revision:1523; number_of_response:1; }","duration":"144.678914ms","start":"2026-07-26T10:25:21.386173Z","end":"2026-07-26T10:25:21.530852Z","steps":["trace[1790311728] 'process raft request' (duration: 144.609943ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.591654Z","caller":"traceutil/trace.go:171","msg":"trace[561215910] linearizableReadLoop","detail":"{readStateIndex:1568; appliedIndex:1552; }","duration":"100.073503ms","start":"2026-07-26T10:25:21.491564Z","end":"2026-07-26T10:25:21.591638Z","steps":["trace[561215910] 'read index received' (duration: 22.957512ms)","trace[561215910] 'applied index is now lower than readState.Index' (duration: 77.115191ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:21.591683Z","caller":"traceutil/trace.go:171","msg":"trace[700156523] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"199.368806ms","start":"2026-07-26T10:25:21.392287Z","end":"2026-07-26T10:25:21.591656Z","steps":["trace[700156523] 'process raft request' (duration: 199.274055ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.591683Z","caller":"traceutil/trace.go:171","msg":"trace[1794129904] transaction","detail":"{read_only:false; response_revision:1525; number_of_response:1; }","duration":"201.288646ms","start":"2026-07-26T10:25:21.390358Z","end":"2026-07-26T10:25:21.591646Z","steps":["trace[1794129904] 'process raft request' (duration: 201.181265ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.591749Z","caller":"traceutil/trace.go:171","msg":"trace[1662955238] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"181.819309ms","start":"2026-07-26T10:25:21.409895Z","end":"2026-07-26T10:25:21.591715Z","steps":["trace[1662955238] 'process raft request' (duration: 181.706588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:21.591815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.245255ms","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-07-26T10:25:21.591838Z","caller":"traceutil/trace.go:171","msg":"trace[1732356959] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1527; }","duration":"100.285325ms","start":"2026-07-26T10:25:21.491547Z","end":"2026-07-26T10:25:21.591832Z","steps":["trace[1732356959] 'agreement among raft nodes before linearized reading' (duration: 100.161034ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:21.591879Z","caller":"traceutil/trace.go:171","msg":"trace[1722628692] transaction","detail":"{read_only:false; response_revision:1524; number_of_response:1; }","duration":"202.63601ms","start":"2026-07-26T10:25:21.38898Z","end":"2026-07-26T10:25:21.591616Z","steps":["trace[1722628692] 'process raft request' (duration: 202.451958ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:26.685635Z","caller":"traceutil/trace.go:171","msg":"trace[175866636] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"153.182832ms","start":"2026-07-26T10:25:26.532422Z","end":"2026-07-26T10:25:26.685605Z","steps":["trace[175866636] 'process raft request' (duration: 152.98904ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:26.925107Z","caller":"traceutil/trace.go:171","msg":"trace[1003347696] linearizableReadLoop","detail":"{readStateIndex:1714; appliedIndex:1713; }","duration":"147.930862ms","start":"2026-07-26T10:25:26.777151Z","end":"2026-07-26T10:25:26.925082Z","steps":["trace[1003347696] 'read index received' (duration: 147.75707ms)","trace[1003347696] 'applied index is now lower than readState.Index' (duration: 172.352µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:26.925149Z","caller":"traceutil/trace.go:171","msg":"trace[520512096] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"349.760158ms","start":"2026-07-26T10:25:26.575357Z","end":"2026-07-26T10:25:26.925117Z","steps":["trace[520512096] 'process raft request' (duration: 349.547146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:26.925303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.142114ms","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-07-26T10:25:26.925336Z","caller":"traceutil/trace.go:171","msg":"trace[971901562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1671; }","duration":"148.234964ms","start":"2026-07-26T10:25:26.777092Z","end":"2026-07-26T10:25:26.925327Z","steps":["trace[971901562] 'agreement among raft nodes before linearized reading' (duration: 148.087443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:26.925691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:26.575315Z","time spent":"349.90497ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:25:46.029916Z","caller":"traceutil/trace.go:171","msg":"trace[1519915286] linearizableReadLoop","detail":"{readStateIndex:2030; appliedIndex:2028; }","duration":"156.539254ms","start":"2026-07-26T10:25:45.873346Z","end":"2026-07-26T10:25:46.029886Z","steps":["trace[1519915286] 'read index received' (duration: 88.250256ms)","trace[1519915286] 'applied index is now lower than readState.Index' (duration: 68.287798ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:46.030023Z","caller":"traceutil/trace.go:171","msg":"trace[71722059] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"265.828769ms","start":"2026-07-26T10:25:45.764135Z","end":"2026-07-26T10:25:46.029964Z","steps":["trace[71722059] 'process raft request' (duration: 197.44835ms)","trace[71722059] 'compare' (duration: 68.006525ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:25:46.03009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.710935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:25:46.030134Z","caller":"traceutil/trace.go:171","msg":"trace[800620351] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1960; }","duration":"156.798906ms","start":"2026-07-26T10:25:45.873324Z","end":"2026-07-26T10:25:46.030123Z","steps":["trace[800620351] 'agreement among raft nodes before linearized reading' (duration: 156.688725ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:46.03021Z","caller":"traceutil/trace.go:171","msg":"trace[1695087012] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"263.091703ms","start":"2026-07-26T10:25:45.767102Z","end":"2026-07-26T10:25:46.030194Z","steps":["trace[1695087012] 'process raft request' (duration: 262.71212ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:46.619081Z","caller":"traceutil/trace.go:171","msg":"trace[832465048] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2032; }","duration":"119.100019ms","start":"2026-07-26T10:25:46.499945Z","end":"2026-07-26T10:25:46.619045Z","steps":["trace[832465048] 'read index received' (duration: 118.851247ms)","trace[832465048] 'applied index is now lower than readState.Index' (duration: 247.452µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:46.619179Z","caller":"traceutil/trace.go:171","msg":"trace[1175216645] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"298.750721ms","start":"2026-07-26T10:25:46.320393Z","end":"2026-07-26T10:25:46.619143Z","steps":["trace[1175216645] 'process raft request' (duration: 298.443738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:46.619405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.407692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-5p5nh\" ","response":"range_response_count:1 size:11628"} {"level":"info","ts":"2026-07-26T10:25:46.61946Z","caller":"traceutil/trace.go:171","msg":"trace[1737488983] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-5p5nh; range_end:; response_count:1; response_revision:1963; }","duration":"119.573823ms","start":"2026-07-26T10:25:46.499874Z","end":"2026-07-26T10:25:46.619447Z","steps":["trace[1737488983] 'agreement among raft nodes before linearized reading' (duration: 119.315131ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:47.047332Z","caller":"traceutil/trace.go:171","msg":"trace[1281944293] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2033; }","duration":"257.41893ms","start":"2026-07-26T10:25:46.789885Z","end":"2026-07-26T10:25:47.047304Z","steps":["trace[1281944293] 'read index received' (duration: 257.178098ms)","trace[1281944293] 'applied index is now lower than readState.Index' (duration: 239.252µs)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:25:47.047634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.766382ms","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-07-26T10:25:47.047501Z","caller":"traceutil/trace.go:171","msg":"trace[130684641] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"415.775021ms","start":"2026-07-26T10:25:46.63168Z","end":"2026-07-26T10:25:47.047455Z","steps":["trace[130684641] 'process raft request' (duration: 415.396328ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:47.047714Z","caller":"traceutil/trace.go:171","msg":"trace[2086614567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1964; }","duration":"257.893313ms","start":"2026-07-26T10:25:46.789804Z","end":"2026-07-26T10:25:47.047697Z","steps":["trace[2086614567] 'agreement among raft nodes before linearized reading' (duration: 257.650911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:47.047846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:46.631649Z","time spent":"416.086254ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11815,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:25:47.130878Z","caller":"traceutil/trace.go:171","msg":"trace[1671922458] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"130.275855ms","start":"2026-07-26T10:25:47.000562Z","end":"2026-07-26T10:25:47.130838Z","steps":["trace[1671922458] 'process raft request' (duration: 130.038992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:47.13148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.933415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:25:47.131549Z","caller":"traceutil/trace.go:171","msg":"trace[1318165822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1965; }","duration":"201.640091ms","start":"2026-07-26T10:25:46.92989Z","end":"2026-07-26T10:25:47.13153Z","steps":["trace[1318165822] 'agreement among raft nodes before linearized reading' (duration: 200.906774ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:47.169111Z","caller":"traceutil/trace.go:171","msg":"trace[1430554086] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"115.945138ms","start":"2026-07-26T10:25:47.05313Z","end":"2026-07-26T10:25:47.169075Z","steps":["trace[1430554086] 'process raft request' (duration: 103.932415ms)","trace[1430554086] 'compare' (duration: 11.847662ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:47.68093Z","caller":"traceutil/trace.go:171","msg":"trace[274655372] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"323.304484ms","start":"2026-07-26T10:25:47.357595Z","end":"2026-07-26T10:25:47.6809Z","steps":["trace[274655372] 'process raft request' (duration: 323.127152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:47.681137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:47.357569Z","time spent":"323.459216ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:25:47.712103Z","caller":"traceutil/trace.go:171","msg":"trace[2062450284] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"169.422425ms","start":"2026-07-26T10:25:47.542632Z","end":"2026-07-26T10:25:47.712055Z","steps":["trace[2062450284] 'process raft request' (duration: 168.097883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:48.073744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.998105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T10:25:48.073881Z","caller":"traceutil/trace.go:171","msg":"trace[703180012] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1972; }","duration":"106.185736ms","start":"2026-07-26T10:25:47.967664Z","end":"2026-07-26T10:25:48.07385Z","steps":["trace[703180012] 'count revisions from in-memory index tree' (duration: 105.918243ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:48.906464Z","caller":"traceutil/trace.go:171","msg":"trace[353895857] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"276.407089ms","start":"2026-07-26T10:25:48.630017Z","end":"2026-07-26T10:25:48.906424Z","steps":["trace[353895857] 'process raft request' (duration: 276.055435ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:49.329878Z","caller":"traceutil/trace.go:171","msg":"trace[1987810927] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"136.995198ms","start":"2026-07-26T10:25:49.19284Z","end":"2026-07-26T10:25:49.329835Z","steps":["trace[1987810927] 'process raft request' (duration: 59.934257ms)","trace[1987810927] 'compare' (duration: 76.295383ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:49.760669Z","caller":"traceutil/trace.go:171","msg":"trace[1721065135] linearizableReadLoop","detail":"{readStateIndex:2053; appliedIndex:2052; }","duration":"240.60844ms","start":"2026-07-26T10:25:49.520045Z","end":"2026-07-26T10:25:49.760653Z","steps":["trace[1721065135] 'read index received' (duration: 240.545279ms)","trace[1721065135] 'applied index is now lower than readState.Index' (duration: 62.221µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:49.760763Z","caller":"traceutil/trace.go:171","msg":"trace[2061068280] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"267.918729ms","start":"2026-07-26T10:25:49.492828Z","end":"2026-07-26T10:25:49.760746Z","steps":["trace[2061068280] 'process raft request' (duration: 267.713637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:49.854339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.276469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-4wcdx\" ","response":"range_response_count:1 size:5534"} {"level":"info","ts":"2026-07-26T10:25:49.854426Z","caller":"traceutil/trace.go:171","msg":"trace[1507686757] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-4wcdx; range_end:; response_count:1; response_revision:1981; }","duration":"334.40311ms","start":"2026-07-26T10:25:49.519997Z","end":"2026-07-26T10:25:49.8544Z","steps":["trace[1507686757] 'agreement among raft nodes before linearized reading' (duration: 240.785992ms)","trace[1507686757] 'range keys from in-memory index tree' (duration: 93.421596ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:25:49.854472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:49.519977Z","time spent":"334.48546ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":5557,"request content":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-4wcdx\" "} {"level":"info","ts":"2026-07-26T10:25:49.854751Z","caller":"traceutil/trace.go:171","msg":"trace[877295041] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"137.904217ms","start":"2026-07-26T10:25:49.716803Z","end":"2026-07-26T10:25:49.854708Z","steps":["trace[877295041] 'process raft request' (duration: 73.551637ms)","trace[877295041] 'compare' (duration: 63.983676ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:49.854798Z","caller":"traceutil/trace.go:171","msg":"trace[1047855269] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"112.166503ms","start":"2026-07-26T10:25:49.742575Z","end":"2026-07-26T10:25:49.854742Z","steps":["trace[1047855269] 'process raft request' (duration: 111.929791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:49.855032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T10:25:49.855056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.132411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-26T10:25:49.855092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.439671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:1 size:27780"} {"level":"info","ts":"2026-07-26T10:25:49.855111Z","caller":"traceutil/trace.go:171","msg":"trace[1620504056] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1985; }","duration":"215.371761ms","start":"2026-07-26T10:25:49.63972Z","end":"2026-07-26T10:25:49.855091Z","steps":["trace[1620504056] 'agreement among raft nodes before linearized reading' (duration: 215.153639ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:49.855151Z","caller":"traceutil/trace.go:171","msg":"trace[473974818] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:1; response_revision:1985; }","duration":"121.525051ms","start":"2026-07-26T10:25:49.733614Z","end":"2026-07-26T10:25:49.85514Z","steps":["trace[473974818] 'agreement among raft nodes before linearized reading' (duration: 121.280599ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:49.855142Z","caller":"traceutil/trace.go:171","msg":"trace[1117221149] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1985; }","duration":"248.260073ms","start":"2026-07-26T10:25:49.606859Z","end":"2026-07-26T10:25:49.855119Z","steps":["trace[1117221149] 'agreement among raft nodes before linearized reading' (duration: 248.022161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:49.855229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.542896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-26T10:25:49.855294Z","caller":"traceutil/trace.go:171","msg":"trace[395253592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1985; }","duration":"169.633237ms","start":"2026-07-26T10:25:49.685642Z","end":"2026-07-26T10:25:49.855275Z","steps":["trace[395253592] 'agreement among raft nodes before linearized reading' (duration: 169.203633ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:50.004494Z","caller":"traceutil/trace.go:171","msg":"trace[454719528] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2057; }","duration":"141.794693ms","start":"2026-07-26T10:25:49.862675Z","end":"2026-07-26T10:25:50.004469Z","steps":["trace[454719528] 'read index received' (duration: 96.938978ms)","trace[454719528] 'applied index is now lower than readState.Index' (duration: 44.854305ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:50.004601Z","caller":"traceutil/trace.go:171","msg":"trace[1165641768] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"144.541789ms","start":"2026-07-26T10:25:49.860018Z","end":"2026-07-26T10:25:50.00456Z","steps":["trace[1165641768] 'process raft request' (duration: 99.553993ms)","trace[1165641768] 'compare' (duration: 44.777224ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:25:50.004833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.091306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:1 size:27780"} {"level":"info","ts":"2026-07-26T10:25:50.00489Z","caller":"traceutil/trace.go:171","msg":"trace[1297995639] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:1; response_revision:1986; }","duration":"142.286008ms","start":"2026-07-26T10:25:49.862592Z","end":"2026-07-26T10:25:50.004878Z","steps":["trace[1297995639] 'agreement among raft nodes before linearized reading' (duration: 142.007615ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:50.018524Z","caller":"traceutil/trace.go:171","msg":"trace[1290957278] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"155.18355ms","start":"2026-07-26T10:25:49.863302Z","end":"2026-07-26T10:25:50.018485Z","steps":["trace[1290957278] 'process raft request' (duration: 154.877147ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:51.110693Z","caller":"traceutil/trace.go:171","msg":"trace[578002201] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"493.827029ms","start":"2026-07-26T10:25:50.616843Z","end":"2026-07-26T10:25:51.11067Z","steps":["trace[578002201] 'process raft request' (duration: 493.679298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.110832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:50.616801Z","time spent":"493.964541ms","remote":"127.0.0.1:60162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10249,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-26T10:25:51.319853Z","caller":"traceutil/trace.go:171","msg":"trace[455888200] linearizableReadLoop","detail":"{readStateIndex:2063; appliedIndex:2061; }","duration":"407.874205ms","start":"2026-07-26T10:25:50.911946Z","end":"2026-07-26T10:25:51.31982Z","steps":["trace[455888200] 'read index received' (duration: 198.590282ms)","trace[455888200] 'applied index is now lower than readState.Index' (duration: 209.282423ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:25:51.319966Z","caller":"traceutil/trace.go:171","msg":"trace[176427402] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"616.35883ms","start":"2026-07-26T10:25:50.703566Z","end":"2026-07-26T10:25:51.319925Z","steps":["trace[176427402] 'process raft request' (duration: 611.815557ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.320081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.111027ms","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-07-26T10:25:51.320171Z","caller":"traceutil/trace.go:171","msg":"trace[137580128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1990; }","duration":"408.258469ms","start":"2026-07-26T10:25:50.91189Z","end":"2026-07-26T10:25:51.320149Z","steps":["trace[137580128] 'agreement among raft nodes before linearized reading' (duration: 408.026837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.320182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:50.703545Z","time spent":"616.515583ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:25:51.320215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:50.911866Z","time spent":"408.34102ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-26T10:25:51.334285Z","caller":"traceutil/trace.go:171","msg":"trace[1968571510] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"217.823454ms","start":"2026-07-26T10:25:51.116417Z","end":"2026-07-26T10:25:51.334241Z","steps":["trace[1968571510] 'process raft request' (duration: 217.574962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.334399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.661363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T10:25:51.334325Z","caller":"traceutil/trace.go:171","msg":"trace[697697433] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"174.508824ms","start":"2026-07-26T10:25:51.159797Z","end":"2026-07-26T10:25:51.334306Z","steps":["trace[697697433] 'process raft request' (duration: 174.345942ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:25:51.334452Z","caller":"traceutil/trace.go:171","msg":"trace[1024902879] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1993; }","duration":"235.764974ms","start":"2026-07-26T10:25:51.098673Z","end":"2026-07-26T10:25:51.334438Z","steps":["trace[1024902879] 'agreement among raft nodes before linearized reading' (duration: 235.658323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.334448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.003298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:25:51.334535Z","caller":"traceutil/trace.go:171","msg":"trace[795151683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1993; }","duration":"405.21401ms","start":"2026-07-26T10:25:50.9293Z","end":"2026-07-26T10:25:51.334514Z","steps":["trace[795151683] 'agreement among raft nodes before linearized reading' (duration: 405.049519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:25:51.334603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:25:50.929277Z","time spent":"405.317271ms","remote":"127.0.0.1:60046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-26T10:25:51.334719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.257978ms","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-07-26T10:25:51.33477Z","caller":"traceutil/trace.go:171","msg":"trace[477653106] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1993; }","duration":"142.37551ms","start":"2026-07-26T10:25:51.192381Z","end":"2026-07-26T10:25:51.334757Z","steps":["trace[477653106] 'agreement among raft nodes before linearized reading' (duration: 141.932786ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:13.225947Z","caller":"traceutil/trace.go:171","msg":"trace[591134064] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"145.589179ms","start":"2026-07-26T10:26:13.080271Z","end":"2026-07-26T10:26:13.22586Z","steps":["trace[591134064] 'process raft request' (duration: 145.353487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:26:13.820162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.229149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:26:13.820345Z","caller":"traceutil/trace.go:171","msg":"trace[1547404151] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"254.498052ms","start":"2026-07-26T10:26:13.565827Z","end":"2026-07-26T10:26:13.820325Z","steps":["trace[1547404151] 'process raft request' (duration: 133.824348ms)","trace[1547404151] 'compare' (duration: 120.059048ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:26:13.820527Z","caller":"traceutil/trace.go:171","msg":"trace[2027867399] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"252.936267ms","start":"2026-07-26T10:26:13.567552Z","end":"2026-07-26T10:26:13.820488Z","steps":["trace[2027867399] 'process raft request' (duration: 252.719765ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:15.700748Z","caller":"traceutil/trace.go:171","msg":"trace[574177396] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"115.764217ms","start":"2026-07-26T10:26:15.584959Z","end":"2026-07-26T10:26:15.700724Z","steps":["trace[574177396] 'process raft request' (duration: 115.562255ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:15.932268Z","caller":"traceutil/trace.go:171","msg":"trace[316065443] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"103.294979ms","start":"2026-07-26T10:26:15.828944Z","end":"2026-07-26T10:26:15.932239Z","steps":["trace[316065443] 'process raft request' (duration: 103.113717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:26:16.217978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.17178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:26:16.218248Z","caller":"traceutil/trace.go:171","msg":"trace[748487832] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"222.030304ms","start":"2026-07-26T10:26:15.996199Z","end":"2026-07-26T10:26:16.21823Z","steps":["trace[748487832] 'process raft request' (duration: 221.888373ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:16.218295Z","caller":"traceutil/trace.go:171","msg":"trace[1079359301] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"387.645323ms","start":"2026-07-26T10:26:15.830604Z","end":"2026-07-26T10:26:16.218249Z","steps":["trace[1079359301] 'process raft request' (duration: 229.09255ms)","trace[1079359301] 'compare' (duration: 157.865617ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:26:16.218401Z","caller":"traceutil/trace.go:171","msg":"trace[738104785] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2257; }","duration":"289.784826ms","start":"2026-07-26T10:26:15.928606Z","end":"2026-07-26T10:26:16.21839Z","steps":["trace[738104785] 'read index received' (duration: 3.563473ms)","trace[738104785] 'applied index is now lower than readState.Index' (duration: 286.219993ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:26:16.218441Z","caller":"traceutil/trace.go:171","msg":"trace[457451683] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"200.656072ms","start":"2026-07-26T10:26:16.017767Z","end":"2026-07-26T10:26:16.218423Z","steps":["trace[457451683] 'process raft request' (duration: 200.42263ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:26:16.21848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:26:15.830586Z","time spent":"387.790154ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:26:16.218529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.908457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:26:16.218616Z","caller":"traceutil/trace.go:171","msg":"trace[1119036961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2183; }","duration":"290.059648ms","start":"2026-07-26T10:26:15.928536Z","end":"2026-07-26T10:26:16.218595Z","steps":["trace[1119036961] 'agreement among raft nodes before linearized reading' (duration: 289.889657ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:16.453291Z","caller":"traceutil/trace.go:171","msg":"trace[1521771232] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"230.161151ms","start":"2026-07-26T10:26:16.223049Z","end":"2026-07-26T10:26:16.45321Z","steps":["trace[1521771232] 'process raft request' (duration: 229.950969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:26:18.732517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.910971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:26:18.732666Z","caller":"traceutil/trace.go:171","msg":"trace[1651620867] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2272; }","duration":"274.878756ms","start":"2026-07-26T10:26:18.457762Z","end":"2026-07-26T10:26:18.732641Z","steps":["trace[1651620867] 'read index received' (duration: 126.699612ms)","trace[1651620867] 'applied index is now lower than readState.Index' (duration: 148.177084ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:26:18.732792Z","caller":"traceutil/trace.go:171","msg":"trace[421440026] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"417.703459ms","start":"2026-07-26T10:26:18.315035Z","end":"2026-07-26T10:26:18.732738Z","steps":["trace[421440026] 'process raft request' (duration: 269.448544ms)","trace[421440026] 'compare' (duration: 147.7586ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:26:18.732944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.188369ms","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-07-26T10:26:18.732985Z","caller":"traceutil/trace.go:171","msg":"trace[1951283106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2194; }","duration":"275.265329ms","start":"2026-07-26T10:26:18.457708Z","end":"2026-07-26T10:26:18.732973Z","steps":["trace[1951283106] 'agreement among raft nodes before linearized reading' (duration: 275.071687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:26:18.733037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:26:18.315003Z","time spent":"417.905042ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:26:18.733497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.28733ms","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-07-26T10:26:18.733608Z","caller":"traceutil/trace.go:171","msg":"trace[29030676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2194; }","duration":"198.478011ms","start":"2026-07-26T10:26:18.535104Z","end":"2026-07-26T10:26:18.733582Z","steps":["trace[29030676] 'agreement among raft nodes before linearized reading' (duration: 197.893135ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:19.410311Z","caller":"traceutil/trace.go:171","msg":"trace[1677982665] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"159.148818ms","start":"2026-07-26T10:26:19.25112Z","end":"2026-07-26T10:26:19.410269Z","steps":["trace[1677982665] 'process raft request' (duration: 158.911915ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:19.712867Z","caller":"traceutil/trace.go:171","msg":"trace[1251965617] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"116.290582ms","start":"2026-07-26T10:26:19.596532Z","end":"2026-07-26T10:26:19.712822Z","steps":["trace[1251965617] 'process raft request' (duration: 85.967565ms)","trace[1251965617] 'compare' (duration: 30.126395ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:26:31.892184Z","caller":"traceutil/trace.go:171","msg":"trace[779014125] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"131.463696ms","start":"2026-07-26T10:26:31.760673Z","end":"2026-07-26T10:26:31.892137Z","steps":["trace[779014125] 'process raft request' (duration: 131.178593ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:55.739676Z","caller":"traceutil/trace.go:171","msg":"trace[936008912] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"185.261575ms","start":"2026-07-26T10:26:55.554377Z","end":"2026-07-26T10:26:55.739638Z","steps":["trace[936008912] 'process raft request' (duration: 184.599328ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:26:57.876041Z","caller":"traceutil/trace.go:171","msg":"trace[882830682] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"131.485269ms","start":"2026-07-26T10:26:57.744521Z","end":"2026-07-26T10:26:57.876006Z","steps":["trace[882830682] 'process raft request' (duration: 131.232987ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:27:09.299566Z","caller":"traceutil/trace.go:171","msg":"trace[27782629] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2539; }","duration":"111.018361ms","start":"2026-07-26T10:27:09.188508Z","end":"2026-07-26T10:27:09.299527Z","steps":["trace[27782629] 'read index received' (duration: 62.551378ms)","trace[27782629] 'applied index is now lower than readState.Index' (duration: 48.465333ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:27:09.299693Z","caller":"traceutil/trace.go:171","msg":"trace[888582908] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"169.068058ms","start":"2026-07-26T10:27:09.130587Z","end":"2026-07-26T10:27:09.299656Z","steps":["trace[888582908] 'process raft request' (duration: 120.493952ms)","trace[888582908] 'compare' (duration: 48.270971ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:27:09.299773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.243565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:27:09.299847Z","caller":"traceutil/trace.go:171","msg":"trace[1367261267] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2451; }","duration":"111.383216ms","start":"2026-07-26T10:27:09.188451Z","end":"2026-07-26T10:27:09.299834Z","steps":["trace[1367261267] 'agreement among raft nodes before linearized reading' (duration: 111.215334ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:27:44.47881Z","caller":"traceutil/trace.go:171","msg":"trace[358222803] linearizableReadLoop","detail":"{readStateIndex:2724; appliedIndex:2723; }","duration":"148.7004ms","start":"2026-07-26T10:27:44.330071Z","end":"2026-07-26T10:27:44.478771Z","steps":["trace[358222803] 'read index received' (duration: 148.455577ms)","trace[358222803] 'applied index is now lower than readState.Index' (duration: 242.943µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:27:44.478876Z","caller":"traceutil/trace.go:171","msg":"trace[184936618] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"213.707907ms","start":"2026-07-26T10:27:44.26513Z","end":"2026-07-26T10:27:44.478837Z","steps":["trace[184936618] 'process raft request' (duration: 213.376002ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:27:44.479067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.972904ms","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-07-26T10:27:44.479142Z","caller":"traceutil/trace.go:171","msg":"trace[303983082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2628; }","duration":"149.103895ms","start":"2026-07-26T10:27:44.330021Z","end":"2026-07-26T10:27:44.479125Z","steps":["trace[303983082] 'agreement among raft nodes before linearized reading' (duration: 148.883333ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:27:44.715978Z","caller":"traceutil/trace.go:171","msg":"trace[804531906] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"148.045222ms","start":"2026-07-26T10:27:44.56787Z","end":"2026-07-26T10:27:44.715915Z","steps":["trace[804531906] 'process raft request' (duration: 49.668568ms)","trace[804531906] 'compare' (duration: 98.165702ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:28:05.84867Z","caller":"traceutil/trace.go:171","msg":"trace[1832337437] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"165.684894ms","start":"2026-07-26T10:28:05.68296Z","end":"2026-07-26T10:28:05.848644Z","steps":["trace[1832337437] 'process raft request' (duration: 165.519731ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:28:06.006517Z","caller":"traceutil/trace.go:171","msg":"trace[1419609014] linearizableReadLoop","detail":"{readStateIndex:2838; appliedIndex:2836; }","duration":"247.03108ms","start":"2026-07-26T10:28:05.759457Z","end":"2026-07-26T10:28:06.006488Z","steps":["trace[1419609014] 'read index received' (duration: 89.016374ms)","trace[1419609014] 'applied index is now lower than readState.Index' (duration: 158.013056ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:28:06.00666Z","caller":"traceutil/trace.go:171","msg":"trace[181725114] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"319.591836ms","start":"2026-07-26T10:28:05.687052Z","end":"2026-07-26T10:28:06.006643Z","steps":["trace[181725114] 'process raft request' (duration: 293.176931ms)","trace[181725114] 'compare' (duration: 25.902104ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:28:06.00677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:28:05.687034Z","time spent":"319.654407ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:28:06.006915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.438379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:28:06.006987Z","caller":"traceutil/trace.go:171","msg":"trace[1066159909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2738; }","duration":"247.53704ms","start":"2026-07-26T10:28:05.75943Z","end":"2026-07-26T10:28:06.006967Z","steps":["trace[1066159909] 'agreement among raft nodes before linearized reading' (duration: 247.420698ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:28:06.777392Z","caller":"traceutil/trace.go:171","msg":"trace[287115081] linearizableReadLoop","detail":"{readStateIndex:2841; appliedIndex:2840; }","duration":"118.079333ms","start":"2026-07-26T10:28:06.659285Z","end":"2026-07-26T10:28:06.777365Z","steps":["trace[287115081] 'read index received' (duration: 117.900039ms)","trace[287115081] 'applied index is now lower than readState.Index' (duration: 177.793µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:28:06.777505Z","caller":"traceutil/trace.go:171","msg":"trace[1021813318] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"201.594844ms","start":"2026-07-26T10:28:06.575872Z","end":"2026-07-26T10:28:06.777467Z","steps":["trace[1021813318] 'process raft request' (duration: 201.228566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:28:06.777611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.304468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-26T10:28:06.777666Z","caller":"traceutil/trace.go:171","msg":"trace[419195884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2741; }","duration":"118.396669ms","start":"2026-07-26T10:28:06.659258Z","end":"2026-07-26T10:28:06.777655Z","steps":["trace[419195884] 'agreement among raft nodes before linearized reading' (duration: 118.223456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:28:14.125479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.629112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:28:14.12558Z","caller":"traceutil/trace.go:171","msg":"trace[332224912] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:2777; }","duration":"147.766135ms","start":"2026-07-26T10:28:13.977792Z","end":"2026-07-26T10:28:14.125558Z","steps":["trace[332224912] 'count revisions from in-memory index tree' (duration: 147.5482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:28:14.125637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.015399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:28:14.125734Z","caller":"traceutil/trace.go:171","msg":"trace[751335373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2777; }","duration":"197.167922ms","start":"2026-07-26T10:28:13.928546Z","end":"2026-07-26T10:28:14.125714Z","steps":["trace[751335373] 'range keys from in-memory index tree' (duration: 196.867626ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:28:16.322762Z","caller":"traceutil/trace.go:171","msg":"trace[1392419594] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"138.652167ms","start":"2026-07-26T10:28:16.184083Z","end":"2026-07-26T10:28:16.322735Z","steps":["trace[1392419594] 'process raft request' (duration: 138.491114ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:28:48.687299Z","caller":"traceutil/trace.go:171","msg":"trace[1048891499] transaction","detail":"{read_only:false; response_revision:2954; number_of_response:1; }","duration":"124.130747ms","start":"2026-07-26T10:28:48.563136Z","end":"2026-07-26T10:28:48.687267Z","steps":["trace[1048891499] 'process raft request' (duration: 65.666493ms)","trace[1048891499] 'compare' (duration: 58.26812ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:28:56.338899Z","caller":"traceutil/trace.go:171","msg":"trace[234647060] transaction","detail":"{read_only:false; response_revision:2994; number_of_response:1; }","duration":"143.86829ms","start":"2026-07-26T10:28:56.195001Z","end":"2026-07-26T10:28:56.338869Z","steps":["trace[234647060] 'process raft request' (duration: 143.418291ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:29:53.278281Z","caller":"traceutil/trace.go:171","msg":"trace[938749120] transaction","detail":"{read_only:false; response_revision:3281; number_of_response:1; }","duration":"194.584813ms","start":"2026-07-26T10:29:53.083672Z","end":"2026-07-26T10:29:53.278257Z","steps":["trace[938749120] 'process raft request' (duration: 194.44599ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:17.121415Z","caller":"traceutil/trace.go:171","msg":"trace[217921560] transaction","detail":"{read_only:false; response_revision:3401; number_of_response:1; }","duration":"122.728402ms","start":"2026-07-26T10:30:16.99864Z","end":"2026-07-26T10:30:17.121368Z","steps":["trace[217921560] 'process raft request' (duration: 122.323203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:17.560822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.552217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-26T10:30:17.560923Z","caller":"traceutil/trace.go:171","msg":"trace[1046914558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3402; }","duration":"104.716141ms","start":"2026-07-26T10:30:17.456185Z","end":"2026-07-26T10:30:17.560901Z","steps":["trace[1046914558] 'range keys from in-memory index tree' (duration: 104.29802ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:17.718666Z","caller":"traceutil/trace.go:171","msg":"trace[253972388] transaction","detail":"{read_only:false; response_revision:3403; number_of_response:1; }","duration":"152.718416ms","start":"2026-07-26T10:30:17.565909Z","end":"2026-07-26T10:30:17.718628Z","steps":["trace[253972388] 'process raft request' (duration: 152.46845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.10963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.312225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:18.109952Z","caller":"traceutil/trace.go:171","msg":"trace[258806521] transaction","detail":"{read_only:false; response_revision:3407; number_of_response:1; }","duration":"272.806ms","start":"2026-07-26T10:30:17.837127Z","end":"2026-07-26T10:30:18.109933Z","steps":["trace[258806521] 'process raft request' (duration: 272.763809ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:18.109959Z","caller":"traceutil/trace.go:171","msg":"trace[1955744562] transaction","detail":"{read_only:false; response_revision:3405; number_of_response:1; }","duration":"483.386794ms","start":"2026-07-26T10:30:17.626555Z","end":"2026-07-26T10:30:18.109942Z","steps":["trace[1955744562] 'process raft request' (duration: 483.206309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.110031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.626543Z","time spent":"483.458275ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:30:18.110038Z","caller":"traceutil/trace.go:171","msg":"trace[1887240565] transaction","detail":"{read_only:false; response_revision:3404; number_of_response:1; }","duration":"486.575574ms","start":"2026-07-26T10:30:17.623396Z","end":"2026-07-26T10:30:18.109971Z","steps":["trace[1887240565] 'process raft request' (duration: 232.805808ms)","trace[1887240565] 'compare' (duration: 253.008598ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:18.110199Z","caller":"traceutil/trace.go:171","msg":"trace[898168874] transaction","detail":"{read_only:false; response_revision:3406; number_of_response:1; }","duration":"482.050784ms","start":"2026-07-26T10:30:17.628135Z","end":"2026-07-26T10:30:18.110186Z","steps":["trace[898168874] 'process raft request' (duration: 481.710947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.110238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.623369Z","time spent":"486.764647ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:30:18.110268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.628094Z","time spent":"482.138446ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:30:18.110329Z","caller":"traceutil/trace.go:171","msg":"trace[2086025292] linearizableReadLoop","detail":"{readStateIndex:3533; appliedIndex:3529; }","duration":"466.533857ms","start":"2026-07-26T10:30:17.643756Z","end":"2026-07-26T10:30:18.11029Z","steps":["trace[2086025292] 'read index received' (duration: 74.636966ms)","trace[2086025292] 'applied index is now lower than readState.Index' (duration: 391.893561ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:18.11062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.974572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:18.110668Z","caller":"traceutil/trace.go:171","msg":"trace[809498891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3407; }","duration":"182.049433ms","start":"2026-07-26T10:30:17.928607Z","end":"2026-07-26T10:30:18.110656Z","steps":["trace[809498891] 'agreement among raft nodes before linearized reading' (duration: 181.971382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.111373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.112656ms","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-07-26T10:30:18.111661Z","caller":"traceutil/trace.go:171","msg":"trace[1233152221] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3407; }","duration":"115.447843ms","start":"2026-07-26T10:30:17.996146Z","end":"2026-07-26T10:30:18.111594Z","steps":["trace[1233152221] 'agreement among raft nodes before linearized reading' (duration: 114.444082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.110598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.806223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:18.111874Z","caller":"traceutil/trace.go:171","msg":"trace[1749104036] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:3407; }","duration":"468.112081ms","start":"2026-07-26T10:30:17.643699Z","end":"2026-07-26T10:30:18.111811Z","steps":["trace[1749104036] 'agreement among raft nodes before linearized reading' (duration: 466.766822ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.111884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.574845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-26T10:30:18.112017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.643681Z","time spent":"468.237973ms","remote":"127.0.0.1:47716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true "} {"level":"warn","ts":"2026-07-26T10:30:18.112058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.87809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-26T10:30:18.1122Z","caller":"traceutil/trace.go:171","msg":"trace[1865806509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3407; }","duration":"323.88989ms","start":"2026-07-26T10:30:17.788213Z","end":"2026-07-26T10:30:18.112103Z","steps":["trace[1865806509] 'agreement among raft nodes before linearized reading' (duration: 322.421329ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:18.112222Z","caller":"traceutil/trace.go:171","msg":"trace[1773544210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3407; }","duration":"330.068495ms","start":"2026-07-26T10:30:17.782098Z","end":"2026-07-26T10:30:18.112167Z","steps":["trace[1773544210] 'agreement among raft nodes before linearized reading' (duration: 328.45444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.112263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.78819Z","time spent":"324.061095ms","remote":"127.0.0.1:60376","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-07-26T10:30:18.112284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:17.78208Z","time spent":"330.188108ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-26T10:30:18.614762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.793944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:18.615101Z","caller":"traceutil/trace.go:171","msg":"trace[127426406] linearizableReadLoop","detail":"{readStateIndex:3536; appliedIndex:3534; }","duration":"447.534663ms","start":"2026-07-26T10:30:18.167544Z","end":"2026-07-26T10:30:18.615078Z","steps":["trace[127426406] 'read index received' (duration: 98.289679ms)","trace[127426406] 'applied index is now lower than readState.Index' (duration: 349.243774ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:18.615186Z","caller":"traceutil/trace.go:171","msg":"trace[1285556169] transaction","detail":"{read_only:false; response_revision:3408; number_of_response:1; }","duration":"494.144248ms","start":"2026-07-26T10:30:18.120993Z","end":"2026-07-26T10:30:18.615137Z","steps":["trace[1285556169] 'process raft request' (duration: 144.829233ms)","trace[1285556169] 'compare' (duration: 348.60539ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:18.615211Z","caller":"traceutil/trace.go:171","msg":"trace[1152500667] transaction","detail":"{read_only:false; response_revision:3409; number_of_response:1; }","duration":"493.881682ms","start":"2026-07-26T10:30:18.121242Z","end":"2026-07-26T10:30:18.615124Z","steps":["trace[1152500667] 'process raft request' (duration: 493.767439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.615441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:18.120967Z","time spent":"494.317312ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:30:18.615456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.209383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-26T10:30:18.615514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:18.121234Z","time spent":"494.105797ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:30:18.615602Z","caller":"traceutil/trace.go:171","msg":"trace[1117805868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3409; }","duration":"157.376486ms","start":"2026-07-26T10:30:18.45818Z","end":"2026-07-26T10:30:18.615557Z","steps":["trace[1117805868] 'agreement among raft nodes before linearized reading' (duration: 157.06627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.615315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.731788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:18.616142Z","caller":"traceutil/trace.go:171","msg":"trace[849973023] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3409; }","duration":"448.584596ms","start":"2026-07-26T10:30:18.167525Z","end":"2026-07-26T10:30:18.61611Z","steps":["trace[849973023] 'agreement among raft nodes before linearized reading' (duration: 447.635336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:18.61621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:18.167505Z","time spent":"448.686218ms","remote":"127.0.0.1:49084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-07-26T10:30:18.769677Z","caller":"traceutil/trace.go:171","msg":"trace[1289903786] transaction","detail":"{read_only:false; response_revision:3410; number_of_response:1; }","duration":"148.259648ms","start":"2026-07-26T10:30:18.621368Z","end":"2026-07-26T10:30:18.769628Z","steps":["trace[1289903786] 'process raft request' (duration: 133.083908ms)","trace[1289903786] 'compare' (duration: 15.012337ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:19.027768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.539148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:19.027929Z","caller":"traceutil/trace.go:171","msg":"trace[643734294] transaction","detail":"{read_only:false; response_revision:3411; number_of_response:1; }","duration":"165.095204ms","start":"2026-07-26T10:30:18.862794Z","end":"2026-07-26T10:30:19.027889Z","steps":["trace[643734294] 'process raft request' (duration: 36.31032ms)","trace[643734294] 'compare' (duration: 128.333864ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:19.337023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.142804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:19.337154Z","caller":"traceutil/trace.go:171","msg":"trace[671567550] transaction","detail":"{read_only:false; response_revision:3412; number_of_response:1; }","duration":"210.036223ms","start":"2026-07-26T10:30:19.127094Z","end":"2026-07-26T10:30:19.33713Z","steps":["trace[671567550] 'process raft request' (duration: 45.664424ms)","trace[671567550] 'compare' (duration: 163.98873ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:19.725782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.394326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T10:30:19.725912Z","caller":"traceutil/trace.go:171","msg":"trace[1044686059] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:3412; }","duration":"196.617071ms","start":"2026-07-26T10:30:19.529269Z","end":"2026-07-26T10:30:19.725886Z","steps":["trace[1044686059] 'count revisions from in-memory index tree' (duration: 196.16261ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:20.02627Z","caller":"traceutil/trace.go:171","msg":"trace[437461524] linearizableReadLoop","detail":"{readStateIndex:3540; appliedIndex:3539; }","duration":"213.99722ms","start":"2026-07-26T10:30:19.812229Z","end":"2026-07-26T10:30:20.026226Z","steps":["trace[437461524] 'read index received' (duration: 213.714543ms)","trace[437461524] 'applied index is now lower than readState.Index' (duration: 281.527µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:20.026465Z","caller":"traceutil/trace.go:171","msg":"trace[679485551] transaction","detail":"{read_only:false; response_revision:3413; number_of_response:1; }","duration":"295.411072ms","start":"2026-07-26T10:30:19.731021Z","end":"2026-07-26T10:30:20.026432Z","steps":["trace[679485551] 'process raft request' (duration: 295.024334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:20.026569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.290256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:20.026619Z","caller":"traceutil/trace.go:171","msg":"trace[86667361] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:3413; }","duration":"214.450619ms","start":"2026-07-26T10:30:19.812157Z","end":"2026-07-26T10:30:20.026608Z","steps":["trace[86667361] 'agreement among raft nodes before linearized reading' (duration: 214.284136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:20.179575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.628791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T10:30:20.179638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.932525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:20.179689Z","caller":"traceutil/trace.go:171","msg":"trace[1889713301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3413; }","duration":"151.812895ms","start":"2026-07-26T10:30:20.02785Z","end":"2026-07-26T10:30:20.179663Z","steps":["trace[1889713301] 'range keys from in-memory index tree' (duration: 151.526868ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:20.180163Z","caller":"traceutil/trace.go:171","msg":"trace[1700017256] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3413; }","duration":"106.093558ms","start":"2026-07-26T10:30:20.073612Z","end":"2026-07-26T10:30:20.179706Z","steps":["trace[1700017256] 'count revisions from in-memory index tree' (duration: 105.722931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:20.430882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.190421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T10:30:20.430965Z","caller":"traceutil/trace.go:171","msg":"trace[141342018] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3417; }","duration":"151.305433ms","start":"2026-07-26T10:30:20.27964Z","end":"2026-07-26T10:30:20.430946Z","steps":["trace[141342018] 'count revisions from in-memory index tree' (duration: 151.13622ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:20.751205Z","caller":"traceutil/trace.go:171","msg":"trace[820955232] transaction","detail":"{read_only:false; response_revision:3418; number_of_response:1; }","duration":"127.163638ms","start":"2026-07-26T10:30:20.624021Z","end":"2026-07-26T10:30:20.751185Z","steps":["trace[820955232] 'process raft request' (duration: 127.009545ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:21.061643Z","caller":"traceutil/trace.go:171","msg":"trace[1851251821] linearizableReadLoop","detail":"{readStateIndex:3546; appliedIndex:3545; }","duration":"288.343788ms","start":"2026-07-26T10:30:20.773273Z","end":"2026-07-26T10:30:21.061617Z","steps":["trace[1851251821] 'read index received' (duration: 288.103962ms)","trace[1851251821] 'applied index is now lower than readState.Index' (duration: 238.585µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:21.061714Z","caller":"traceutil/trace.go:171","msg":"trace[995913134] transaction","detail":"{read_only:false; response_revision:3419; number_of_response:1; }","duration":"437.162927ms","start":"2026-07-26T10:30:20.624523Z","end":"2026-07-26T10:30:21.061686Z","steps":["trace[995913134] 'process raft request' (duration: 436.881511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:21.061848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:20.624501Z","time spent":"437.26992ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:30:21.061895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.601914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-26T10:30:21.061938Z","caller":"traceutil/trace.go:171","msg":"trace[2021756022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3419; }","duration":"288.720106ms","start":"2026-07-26T10:30:20.773202Z","end":"2026-07-26T10:30:21.061922Z","steps":["trace[2021756022] 'agreement among raft nodes before linearized reading' (duration: 288.564623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:21.061979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.768379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:21.062081Z","caller":"traceutil/trace.go:171","msg":"trace[1633988082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3419; }","duration":"131.915552ms","start":"2026-07-26T10:30:20.930139Z","end":"2026-07-26T10:30:21.062055Z","steps":["trace[1633988082] 'agreement among raft nodes before linearized reading' (duration: 131.765089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:21.33827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.469977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:21.338427Z","caller":"traceutil/trace.go:171","msg":"trace[1617836848] transaction","detail":"{read_only:false; response_revision:3420; number_of_response:1; }","duration":"271.975541ms","start":"2026-07-26T10:30:21.066424Z","end":"2026-07-26T10:30:21.3384Z","steps":["trace[1617836848] 'process raft request' (duration: 160.218187ms)","trace[1617836848] 'compare' (duration: 111.223002ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:21.375539Z","caller":"traceutil/trace.go:171","msg":"trace[1966663771] transaction","detail":"{read_only:false; response_revision:3421; number_of_response:1; }","duration":"308.596798ms","start":"2026-07-26T10:30:21.066913Z","end":"2026-07-26T10:30:21.37551Z","steps":["trace[1966663771] 'process raft request' (duration: 308.425335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:21.375731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:21.066898Z","time spent":"308.733881ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:30:21.538583Z","caller":"traceutil/trace.go:171","msg":"trace[499737944] transaction","detail":"{read_only:false; response_revision:3422; number_of_response:1; }","duration":"195.995807ms","start":"2026-07-26T10:30:21.342548Z","end":"2026-07-26T10:30:21.538544Z","steps":["trace[499737944] 'process raft request' (duration: 150.283893ms)","trace[499737944] 'compare' (duration: 45.553171ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:22.266276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.313539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:22.266361Z","caller":"traceutil/trace.go:171","msg":"trace[1878365314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3423; }","duration":"335.447883ms","start":"2026-07-26T10:30:21.930894Z","end":"2026-07-26T10:30:22.266342Z","steps":["trace[1878365314] 'range keys from in-memory index tree' (duration: 335.205947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:22.266405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:30:21.930868Z","time spent":"335.526484ms","remote":"127.0.0.1:60046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-26T10:30:22.266751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.58017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-26T10:30:22.266789Z","caller":"traceutil/trace.go:171","msg":"trace[1733338659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3423; }","duration":"236.658421ms","start":"2026-07-26T10:30:22.030121Z","end":"2026-07-26T10:30:22.26678Z","steps":["trace[1733338659] 'range keys from in-memory index tree' (duration: 236.392266ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.415677Z","caller":"traceutil/trace.go:171","msg":"trace[2004841542] transaction","detail":"{read_only:false; response_revision:3424; number_of_response:1; }","duration":"198.895401ms","start":"2026-07-26T10:30:22.216756Z","end":"2026-07-26T10:30:22.415651Z","steps":["trace[2004841542] 'process raft request' (duration: 198.696175ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.428359Z","caller":"traceutil/trace.go:171","msg":"trace[1142047065] transaction","detail":"{read_only:false; response_revision:3425; number_of_response:1; }","duration":"211.428932ms","start":"2026-07-26T10:30:22.2169Z","end":"2026-07-26T10:30:22.428329Z","steps":["trace[1142047065] 'process raft request' (duration: 211.152046ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.428709Z","caller":"traceutil/trace.go:171","msg":"trace[120577167] transaction","detail":"{read_only:false; response_revision:3426; number_of_response:1; }","duration":"210.669047ms","start":"2026-07-26T10:30:22.218014Z","end":"2026-07-26T10:30:22.428683Z","steps":["trace[120577167] 'process raft request' (duration: 210.262298ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.428721Z","caller":"traceutil/trace.go:171","msg":"trace[1966568488] linearizableReadLoop","detail":"{readStateIndex:3553; appliedIndex:3550; }","duration":"160.852322ms","start":"2026-07-26T10:30:22.267844Z","end":"2026-07-26T10:30:22.428696Z","steps":["trace[1966568488] 'read index received' (duration: 147.624124ms)","trace[1966568488] 'applied index is now lower than readState.Index' (duration: 13.226578ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:22.428771Z","caller":"traceutil/trace.go:171","msg":"trace[1009799886] transaction","detail":"{read_only:false; response_revision:3427; number_of_response:1; }","duration":"157.499299ms","start":"2026-07-26T10:30:22.271245Z","end":"2026-07-26T10:30:22.428744Z","steps":["trace[1009799886] 'process raft request' (duration: 157.330735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:22.42892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.057876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T10:30:22.428938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.483103ms","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-07-26T10:30:22.429002Z","caller":"traceutil/trace.go:171","msg":"trace[1858471704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3427; }","duration":"161.189059ms","start":"2026-07-26T10:30:22.267783Z","end":"2026-07-26T10:30:22.428972Z","steps":["trace[1858471704] 'agreement among raft nodes before linearized reading' (duration: 161.069066ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.429054Z","caller":"traceutil/trace.go:171","msg":"trace[1957666123] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3427; }","duration":"109.668358ms","start":"2026-07-26T10:30:22.319353Z","end":"2026-07-26T10:30:22.429021Z","steps":["trace[1957666123] 'agreement among raft nodes before linearized reading' (duration: 109.493444ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:22.877143Z","caller":"traceutil/trace.go:171","msg":"trace[1990998334] transaction","detail":"{read_only:false; response_revision:3428; number_of_response:1; }","duration":"116.377083ms","start":"2026-07-26T10:30:22.76074Z","end":"2026-07-26T10:30:22.877117Z","steps":["trace[1990998334] 'process raft request' (duration: 116.025216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:23.18604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.232976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-26T10:30:23.18616Z","caller":"traceutil/trace.go:171","msg":"trace[132716667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3428; }","duration":"119.44391ms","start":"2026-07-26T10:30:23.066687Z","end":"2026-07-26T10:30:23.186131Z","steps":["trace[132716667] 'range keys from in-memory index tree' (duration: 118.932689ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:30.635488Z","caller":"traceutil/trace.go:171","msg":"trace[33615224] transaction","detail":"{read_only:false; response_revision:3466; number_of_response:1; }","duration":"179.038338ms","start":"2026-07-26T10:30:30.456425Z","end":"2026-07-26T10:30:30.635464Z","steps":["trace[33615224] 'process raft request' (duration: 123.035398ms)","trace[33615224] 'compare' (duration: 55.831036ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:30.635678Z","caller":"traceutil/trace.go:171","msg":"trace[832235853] transaction","detail":"{read_only:false; response_revision:3467; number_of_response:1; }","duration":"176.234147ms","start":"2026-07-26T10:30:30.459436Z","end":"2026-07-26T10:30:30.63567Z","steps":["trace[832235853] 'process raft request' (duration: 175.993462ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:30.635709Z","caller":"traceutil/trace.go:171","msg":"trace[1395906969] linearizableReadLoop","detail":"{readStateIndex:3596; appliedIndex:3594; }","duration":"124.91844ms","start":"2026-07-26T10:30:30.510754Z","end":"2026-07-26T10:30:30.635672Z","steps":["trace[1395906969] 'read index received' (duration: 68.621354ms)","trace[1395906969] 'applied index is now lower than readState.Index' (duration: 56.294696ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:30.636033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.399179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-26T10:30:30.636147Z","caller":"traceutil/trace.go:171","msg":"trace[752070942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3467; }","duration":"169.542821ms","start":"2026-07-26T10:30:30.466569Z","end":"2026-07-26T10:30:30.636111Z","steps":["trace[752070942] 'agreement among raft nodes before linearized reading' (duration: 169.187064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:30.996929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.541191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:30.997036Z","caller":"traceutil/trace.go:171","msg":"trace[2076444577] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:3468; }","duration":"191.706265ms","start":"2026-07-26T10:30:30.805298Z","end":"2026-07-26T10:30:30.997005Z","steps":["trace[2076444577] 'count revisions from in-memory index tree' (duration: 191.393288ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:35.403569Z","caller":"traceutil/trace.go:171","msg":"trace[1076977116] linearizableReadLoop","detail":"{readStateIndex:3620; appliedIndex:3619; }","duration":"165.120745ms","start":"2026-07-26T10:30:35.238408Z","end":"2026-07-26T10:30:35.403528Z","steps":["trace[1076977116] 'read index received' (duration: 162.197191ms)","trace[1076977116] 'applied index is now lower than readState.Index' (duration: 2.922274ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:35.40384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.40178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T10:30:35.403637Z","caller":"traceutil/trace.go:171","msg":"trace[620047165] transaction","detail":"{read_only:false; response_revision:3490; number_of_response:1; }","duration":"197.807456ms","start":"2026-07-26T10:30:35.205797Z","end":"2026-07-26T10:30:35.403605Z","steps":["trace[620047165] 'process raft request' (duration: 194.824762ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:35.403949Z","caller":"traceutil/trace.go:171","msg":"trace[359018139] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:3490; }","duration":"165.583764ms","start":"2026-07-26T10:30:35.238342Z","end":"2026-07-26T10:30:35.403926Z","steps":["trace[359018139] 'agreement among raft nodes before linearized reading' (duration: 165.350459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:35.404319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.881179ms","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-07-26T10:30:35.4044Z","caller":"traceutil/trace.go:171","msg":"trace[1214552974] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3490; }","duration":"159.049603ms","start":"2026-07-26T10:30:35.245332Z","end":"2026-07-26T10:30:35.404382Z","steps":["trace[1214552974] 'agreement among raft nodes before linearized reading' (duration: 158.828398ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:37.335622Z","caller":"traceutil/trace.go:171","msg":"trace[1008055041] transaction","detail":"{read_only:false; response_revision:3500; number_of_response:1; }","duration":"188.270918ms","start":"2026-07-26T10:30:37.14731Z","end":"2026-07-26T10:30:37.335581Z","steps":["trace[1008055041] 'process raft request' (duration: 149.417333ms)","trace[1008055041] 'compare' (duration: 38.656941ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:37.338204Z","caller":"traceutil/trace.go:171","msg":"trace[1250573723] transaction","detail":"{read_only:false; response_revision:3501; number_of_response:1; }","duration":"187.049202ms","start":"2026-07-26T10:30:37.151127Z","end":"2026-07-26T10:30:37.338177Z","steps":["trace[1250573723] 'process raft request' (duration: 186.741675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:44.78824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.597771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:44.78833Z","caller":"traceutil/trace.go:171","msg":"trace[2025228801] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:3535; }","duration":"253.757234ms","start":"2026-07-26T10:30:44.53455Z","end":"2026-07-26T10:30:44.788308Z","steps":["trace[2025228801] 'count revisions from in-memory index tree' (duration: 253.462829ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:44.788665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.765978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:30:44.788815Z","caller":"traceutil/trace.go:171","msg":"trace[854330027] transaction","detail":"{read_only:false; response_revision:3536; number_of_response:1; }","duration":"222.082724ms","start":"2026-07-26T10:30:44.566704Z","end":"2026-07-26T10:30:44.788787Z","steps":["trace[854330027] 'process raft request' (duration: 68.045401ms)","trace[854330027] 'compare' (duration: 153.350179ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:44.791614Z","caller":"traceutil/trace.go:171","msg":"trace[529704997] transaction","detail":"{read_only:false; response_revision:3537; number_of_response:1; }","duration":"106.714983ms","start":"2026-07-26T10:30:44.684863Z","end":"2026-07-26T10:30:44.791578Z","steps":["trace[529704997] 'process raft request' (duration: 106.55369ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:44.929282Z","caller":"traceutil/trace.go:171","msg":"trace[326438282] transaction","detail":"{read_only:false; response_revision:3538; number_of_response:1; }","duration":"242.432968ms","start":"2026-07-26T10:30:44.686817Z","end":"2026-07-26T10:30:44.92925Z","steps":["trace[326438282] 'process raft request' (duration: 221.277367ms)","trace[326438282] 'compare' (duration: 20.914005ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:44.929227Z","caller":"traceutil/trace.go:171","msg":"trace[2109540669] linearizableReadLoop","detail":"{readStateIndex:3670; appliedIndex:3668; }","duration":"145.741383ms","start":"2026-07-26T10:30:44.783446Z","end":"2026-07-26T10:30:44.929187Z","steps":["trace[2109540669] 'read index received' (duration: 7.915253ms)","trace[2109540669] 'applied index is now lower than readState.Index' (duration: 137.82303ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:30:44.929666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.179082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-26T10:30:44.929737Z","caller":"traceutil/trace.go:171","msg":"trace[662151421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3538; }","duration":"146.319626ms","start":"2026-07-26T10:30:44.783401Z","end":"2026-07-26T10:30:44.929721Z","steps":["trace[662151421] 'agreement among raft nodes before linearized reading' (duration: 145.938458ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:50.515672Z","caller":"traceutil/trace.go:171","msg":"trace[1713758524] transaction","detail":"{read_only:false; response_revision:3566; number_of_response:1; }","duration":"105.496156ms","start":"2026-07-26T10:30:50.410139Z","end":"2026-07-26T10:30:50.515635Z","steps":["trace[1713758524] 'process raft request' (duration: 105.297142ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:51.099826Z","caller":"traceutil/trace.go:171","msg":"trace[1050500086] linearizableReadLoop","detail":"{readStateIndex:3701; appliedIndex:3700; }","duration":"170.595004ms","start":"2026-07-26T10:30:50.929208Z","end":"2026-07-26T10:30:51.099803Z","steps":["trace[1050500086] 'read index received' (duration: 170.40582ms)","trace[1050500086] 'applied index is now lower than readState.Index' (duration: 188.184µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:30:51.099983Z","caller":"traceutil/trace.go:171","msg":"trace[2012179020] transaction","detail":"{read_only:false; response_revision:3568; number_of_response:1; }","duration":"284.899133ms","start":"2026-07-26T10:30:50.815069Z","end":"2026-07-26T10:30:51.099968Z","steps":["trace[2012179020] 'process raft request' (duration: 284.540255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:51.100387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.053494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:30:51.100588Z","caller":"traceutil/trace.go:171","msg":"trace[1192063540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3568; }","duration":"171.397461ms","start":"2026-07-26T10:30:50.92915Z","end":"2026-07-26T10:30:51.100548Z","steps":["trace[1192063540] 'agreement among raft nodes before linearized reading' (duration: 170.976732ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:30:51.101523Z","caller":"traceutil/trace.go:171","msg":"trace[900837601] transaction","detail":"{read_only:false; response_revision:3569; number_of_response:1; }","duration":"154.361711ms","start":"2026-07-26T10:30:50.947143Z","end":"2026-07-26T10:30:51.101505Z","steps":["trace[900837601] 'process raft request' (duration: 154.063474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:30:51.101526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.57002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-26T10:30:51.101775Z","caller":"traceutil/trace.go:171","msg":"trace[1466337983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3569; }","duration":"140.868828ms","start":"2026-07-26T10:30:50.960885Z","end":"2026-07-26T10:30:51.101754Z","steps":["trace[1466337983] 'agreement among raft nodes before linearized reading' (duration: 140.444478ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.040206Z","caller":"traceutil/trace.go:171","msg":"trace[1269624630] transaction","detail":"{read_only:false; response_revision:3617; number_of_response:1; }","duration":"101.652131ms","start":"2026-07-26T10:31:00.938525Z","end":"2026-07-26T10:31:01.040177Z","steps":["trace[1269624630] 'process raft request' (duration: 101.439227ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.465909Z","caller":"traceutil/trace.go:171","msg":"trace[1305311191] transaction","detail":"{read_only:false; response_revision:3618; number_of_response:1; }","duration":"280.883436ms","start":"2026-07-26T10:31:01.184997Z","end":"2026-07-26T10:31:01.46588Z","steps":["trace[1305311191] 'process raft request' (duration: 280.708683ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.617856Z","caller":"traceutil/trace.go:171","msg":"trace[1076416149] linearizableReadLoop","detail":"{readStateIndex:3754; appliedIndex:3752; }","duration":"405.480741ms","start":"2026-07-26T10:31:01.212341Z","end":"2026-07-26T10:31:01.617822Z","steps":["trace[1076416149] 'read index received' (duration: 253.306911ms)","trace[1076416149] 'applied index is now lower than readState.Index' (duration: 152.17276ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:01.617904Z","caller":"traceutil/trace.go:171","msg":"trace[1714777735] transaction","detail":"{read_only:false; response_revision:3619; number_of_response:1; }","duration":"428.569848ms","start":"2026-07-26T10:31:01.189298Z","end":"2026-07-26T10:31:01.617868Z","steps":["trace[1714777735] 'process raft request' (duration: 398.911522ms)","trace[1714777735] 'compare' (duration: 29.473113ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:31:01.618077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:31:01.189169Z","time spent":"428.810693ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:31:01.618199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.823709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-26T10:31:01.618271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.984697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-26T10:31:01.618303Z","caller":"traceutil/trace.go:171","msg":"trace[758801399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3619; }","duration":"405.980981ms","start":"2026-07-26T10:31:01.212295Z","end":"2026-07-26T10:31:01.618276Z","steps":["trace[758801399] 'agreement among raft nodes before linearized reading' (duration: 405.658155ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.61833Z","caller":"traceutil/trace.go:171","msg":"trace[1648241150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3619; }","duration":"106.092019ms","start":"2026-07-26T10:31:01.512224Z","end":"2026-07-26T10:31:01.618316Z","steps":["trace[1648241150] 'agreement among raft nodes before linearized reading' (duration: 105.875375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:31:01.618348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:31:01.212276Z","time spent":"406.065953ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-26T10:31:01.618701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.933454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:413314"} {"level":"info","ts":"2026-07-26T10:31:01.618721Z","caller":"traceutil/trace.go:171","msg":"trace[1595590957] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:3619; }","duration":"204.007096ms","start":"2026-07-26T10:31:01.414707Z","end":"2026-07-26T10:31:01.618714Z","steps":["trace[1595590957] 'agreement among raft nodes before linearized reading' (duration: 203.297552ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.756451Z","caller":"traceutil/trace.go:171","msg":"trace[251256309] transaction","detail":"{read_only:false; response_revision:3620; number_of_response:1; }","duration":"132.706165ms","start":"2026-07-26T10:31:01.623702Z","end":"2026-07-26T10:31:01.756408Z","steps":["trace[251256309] 'process raft request' (duration: 102.524807ms)","trace[251256309] 'compare' (duration: 30.009844ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:01.837828Z","caller":"traceutil/trace.go:171","msg":"trace[546964761] transaction","detail":"{read_only:false; response_revision:3621; number_of_response:1; }","duration":"213.896002ms","start":"2026-07-26T10:31:01.623899Z","end":"2026-07-26T10:31:01.837795Z","steps":["trace[546964761] 'process raft request' (duration: 213.622606ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.83789Z","caller":"traceutil/trace.go:171","msg":"trace[871505553] transaction","detail":"{read_only:false; response_revision:3622; number_of_response:1; }","duration":"213.976543ms","start":"2026-07-26T10:31:01.623874Z","end":"2026-07-26T10:31:01.837851Z","steps":["trace[871505553] 'process raft request' (duration: 213.801359ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.837826Z","caller":"traceutil/trace.go:171","msg":"trace[2139216313] transaction","detail":"{read_only:false; response_revision:3623; number_of_response:1; }","duration":"213.914902ms","start":"2026-07-26T10:31:01.623881Z","end":"2026-07-26T10:31:01.837796Z","steps":["trace[2139216313] 'process raft request' (duration: 213.84208ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.837923Z","caller":"traceutil/trace.go:171","msg":"trace[429369070] transaction","detail":"{read_only:false; response_revision:3624; number_of_response:1; }","duration":"213.624886ms","start":"2026-07-26T10:31:01.624289Z","end":"2026-07-26T10:31:01.837914Z","steps":["trace[429369070] 'process raft request' (duration: 213.469053ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:01.885014Z","caller":"traceutil/trace.go:171","msg":"trace[1815857651] transaction","detail":"{read_only:false; response_revision:3625; number_of_response:1; }","duration":"155.570168ms","start":"2026-07-26T10:31:01.729402Z","end":"2026-07-26T10:31:01.884972Z","steps":["trace[1815857651] 'process raft request' (duration: 142.199934ms)","trace[1815857651] 'compare' (duration: 13.195551ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:15.635124Z","caller":"traceutil/trace.go:171","msg":"trace[1498781723] linearizableReadLoop","detail":"{readStateIndex:3827; appliedIndex:3826; }","duration":"103.290283ms","start":"2026-07-26T10:31:15.53181Z","end":"2026-07-26T10:31:15.6351Z","steps":["trace[1498781723] 'read index received' (duration: 103.234852ms)","trace[1498781723] 'applied index is now lower than readState.Index' (duration: 54.021µs)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:31:15.635263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.428526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T10:31:15.635293Z","caller":"traceutil/trace.go:171","msg":"trace[1195941738] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:3689; }","duration":"103.490417ms","start":"2026-07-26T10:31:15.531792Z","end":"2026-07-26T10:31:15.635282Z","steps":["trace[1195941738] 'agreement among raft nodes before linearized reading' (duration: 103.408735ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:15.635239Z","caller":"traceutil/trace.go:171","msg":"trace[209933022] transaction","detail":"{read_only:false; response_revision:3689; number_of_response:1; }","duration":"111.338953ms","start":"2026-07-26T10:31:15.523832Z","end":"2026-07-26T10:31:15.635171Z","steps":["trace[209933022] 'process raft request' (duration: 111.042417ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:15.914782Z","caller":"traceutil/trace.go:171","msg":"trace[1870743461] transaction","detail":"{read_only:false; response_revision:3690; number_of_response:1; }","duration":"209.581456ms","start":"2026-07-26T10:31:15.705163Z","end":"2026-07-26T10:31:15.914744Z","steps":["trace[1870743461] 'process raft request' (duration: 209.248449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:31:16.135888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.373246ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:31:16.136248Z","caller":"traceutil/trace.go:171","msg":"trace[1315068650] transaction","detail":"{read_only:false; response_revision:3693; number_of_response:1; }","duration":"216.048883ms","start":"2026-07-26T10:31:15.92018Z","end":"2026-07-26T10:31:16.136229Z","steps":["trace[1315068650] 'process raft request' (duration: 215.964791ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:16.136226Z","caller":"traceutil/trace.go:171","msg":"trace[1188730698] transaction","detail":"{read_only:false; response_revision:3691; number_of_response:1; }","duration":"216.862239ms","start":"2026-07-26T10:31:15.919303Z","end":"2026-07-26T10:31:16.136166Z","steps":["trace[1188730698] 'process raft request' (duration: 69.093436ms)","trace[1188730698] 'compare' (duration: 146.525349ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:16.136285Z","caller":"traceutil/trace.go:171","msg":"trace[1705417570] transaction","detail":"{read_only:false; response_revision:3692; number_of_response:1; }","duration":"216.477101ms","start":"2026-07-26T10:31:15.919767Z","end":"2026-07-26T10:31:16.136244Z","steps":["trace[1705417570] 'process raft request' (duration: 216.268327ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:16.136555Z","caller":"traceutil/trace.go:171","msg":"trace[772831693] transaction","detail":"{read_only:false; response_revision:3694; number_of_response:1; }","duration":"216.293978ms","start":"2026-07-26T10:31:15.920245Z","end":"2026-07-26T10:31:16.136539Z","steps":["trace[772831693] 'process raft request' (duration: 215.941871ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:16.13676Z","caller":"traceutil/trace.go:171","msg":"trace[460521005] transaction","detail":"{read_only:false; response_revision:3696; number_of_response:1; }","duration":"200.324152ms","start":"2026-07-26T10:31:15.93642Z","end":"2026-07-26T10:31:16.136744Z","steps":["trace[460521005] 'process raft request' (duration: 200.20595ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:16.136752Z","caller":"traceutil/trace.go:171","msg":"trace[1209022875] transaction","detail":"{read_only:false; response_revision:3695; number_of_response:1; }","duration":"215.925451ms","start":"2026-07-26T10:31:15.920784Z","end":"2026-07-26T10:31:16.13671Z","steps":["trace[1209022875] 'process raft request' (duration: 215.661746ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:23.965274Z","caller":"traceutil/trace.go:171","msg":"trace[1588817429] transaction","detail":"{read_only:false; response_revision:3730; number_of_response:1; }","duration":"303.431284ms","start":"2026-07-26T10:31:23.661804Z","end":"2026-07-26T10:31:23.965235Z","steps":["trace[1588817429] 'process raft request' (duration: 302.955585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:31:23.965498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:31:23.661778Z","time spent":"303.589946ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:31:58.662237Z","caller":"traceutil/trace.go:171","msg":"trace[822446087] transaction","detail":"{read_only:false; response_revision:3907; number_of_response:1; }","duration":"187.505509ms","start":"2026-07-26T10:31:58.47471Z","end":"2026-07-26T10:31:58.662215Z","steps":["trace[822446087] 'process raft request' (duration: 187.358615ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:58.771499Z","caller":"traceutil/trace.go:171","msg":"trace[1155229779] transaction","detail":"{read_only:false; response_revision:3908; number_of_response:1; }","duration":"296.413014ms","start":"2026-07-26T10:31:58.475066Z","end":"2026-07-26T10:31:58.771479Z","steps":["trace[1155229779] 'process raft request' (duration: 283.067139ms)","trace[1155229779] 'compare' (duration: 13.207401ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:58.771804Z","caller":"traceutil/trace.go:171","msg":"trace[655526964] transaction","detail":"{read_only:false; response_revision:3909; number_of_response:1; }","duration":"296.16484ms","start":"2026-07-26T10:31:58.475624Z","end":"2026-07-26T10:31:58.771789Z","steps":["trace[655526964] 'process raft request' (duration: 295.807843ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:31:58.771842Z","caller":"traceutil/trace.go:171","msg":"trace[770047321] linearizableReadLoop","detail":"{readStateIndex:4056; appliedIndex:4054; }","duration":"295.840963ms","start":"2026-07-26T10:31:58.475965Z","end":"2026-07-26T10:31:58.771806Z","steps":["trace[770047321] 'read index received' (duration: 186.240785ms)","trace[770047321] 'applied index is now lower than readState.Index' (duration: 109.598888ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:31:58.772044Z","caller":"traceutil/trace.go:171","msg":"trace[202785123] transaction","detail":"{read_only:false; response_revision:3910; number_of_response:1; }","duration":"295.513407ms","start":"2026-07-26T10:31:58.476487Z","end":"2026-07-26T10:31:58.772Z","steps":["trace[202785123] 'process raft request' (duration: 295.17281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:31:58.772201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.20167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-26T10:31:58.772258Z","caller":"traceutil/trace.go:171","msg":"trace[1548958644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3910; }","duration":"296.300192ms","start":"2026-07-26T10:31:58.475946Z","end":"2026-07-26T10:31:58.772246Z","steps":["trace[1548958644] 'agreement among raft nodes before linearized reading' (duration: 296.042157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:31:59.085491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.845563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:31:59.085774Z","caller":"traceutil/trace.go:171","msg":"trace[1729653995] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"308.607865ms","start":"2026-07-26T10:31:58.77712Z","end":"2026-07-26T10:31:59.085728Z","steps":["trace[1729653995] 'process raft request' (duration: 151.379555ms)","trace[1729653995] 'compare' (duration: 156.589087ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:31:59.086157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:31:58.777095Z","time spent":"308.89808ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:32:30.460849Z","caller":"traceutil/trace.go:171","msg":"trace[1174861137] transaction","detail":"{read_only:false; response_revision:4068; number_of_response:1; }","duration":"131.034314ms","start":"2026-07-26T10:32:30.329762Z","end":"2026-07-26T10:32:30.460796Z","steps":["trace[1174861137] 'process raft request' (duration: 130.653306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:32:37.480012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.139026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:32:37.480293Z","caller":"traceutil/trace.go:171","msg":"trace[414867490] linearizableReadLoop","detail":"{readStateIndex:4259; appliedIndex:4256; }","duration":"363.242132ms","start":"2026-07-26T10:32:37.117031Z","end":"2026-07-26T10:32:37.480273Z","steps":["trace[414867490] 'read index received' (duration: 34.95421ms)","trace[414867490] 'applied index is now lower than readState.Index' (duration: 328.286392ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:32:37.480386Z","caller":"traceutil/trace.go:171","msg":"trace[551287526] transaction","detail":"{read_only:false; response_revision:4103; number_of_response:1; }","duration":"364.914846ms","start":"2026-07-26T10:32:37.115431Z","end":"2026-07-26T10:32:37.480346Z","steps":["trace[551287526] 'process raft request' (duration: 138.146588ms)","trace[551287526] 'compare' (duration: 225.983393ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:32:37.480554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:32:37.115395Z","time spent":"365.07356ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T10:32:37.480627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.575198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-26T10:32:37.480756Z","caller":"traceutil/trace.go:171","msg":"trace[1068600339] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:4104; }","duration":"363.740433ms","start":"2026-07-26T10:32:37.11699Z","end":"2026-07-26T10:32:37.480731Z","steps":["trace[1068600339] 'agreement among raft nodes before linearized reading' (duration: 363.499967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:32:37.480783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.65205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-26T10:32:37.4808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:32:37.116971Z","time spent":"363.821634ms","remote":"127.0.0.1:60390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-07-26T10:32:37.480848Z","caller":"traceutil/trace.go:171","msg":"trace[2146728704] transaction","detail":"{read_only:false; response_revision:4105; number_of_response:1; }","duration":"228.411022ms","start":"2026-07-26T10:32:37.252423Z","end":"2026-07-26T10:32:37.480834Z","steps":["trace[2146728704] 'process raft request' (duration: 227.816869ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:32:37.48086Z","caller":"traceutil/trace.go:171","msg":"trace[1168674095] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4105; }","duration":"142.771051ms","start":"2026-07-26T10:32:37.338069Z","end":"2026-07-26T10:32:37.48084Z","steps":["trace[1168674095] 'agreement among raft nodes before linearized reading' (duration: 142.506775ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:32:37.480583Z","caller":"traceutil/trace.go:171","msg":"trace[606987654] transaction","detail":"{read_only:false; response_revision:4104; number_of_response:1; }","duration":"364.363935ms","start":"2026-07-26T10:32:37.116027Z","end":"2026-07-26T10:32:37.480391Z","steps":["trace[606987654] 'process raft request' (duration: 364.136081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:32:37.481454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:32:37.116007Z","time spent":"365.000429ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:33:09.561129Z","caller":"traceutil/trace.go:171","msg":"trace[1123929084] transaction","detail":"{read_only:false; response_revision:4265; number_of_response:1; }","duration":"158.024151ms","start":"2026-07-26T10:33:09.403072Z","end":"2026-07-26T10:33:09.561096Z","steps":["trace[1123929084] 'process raft request' (duration: 157.848348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:33:12.221488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.067935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:33:12.222172Z","caller":"traceutil/trace.go:171","msg":"trace[2103586393] transaction","detail":"{read_only:false; response_revision:4280; number_of_response:1; }","duration":"478.087719ms","start":"2026-07-26T10:33:11.744024Z","end":"2026-07-26T10:33:12.222111Z","steps":["trace[2103586393] 'process raft request' (duration: 170.248838ms)","trace[2103586393] 'compare' (duration: 306.780849ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T10:33:12.222434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T10:33:11.744012Z","time spent":"478.292173ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T10:33:15.866405Z","caller":"traceutil/trace.go:171","msg":"trace[477492513] linearizableReadLoop","detail":"{readStateIndex:4456; appliedIndex:4455; }","duration":"108.676098ms","start":"2026-07-26T10:33:15.757705Z","end":"2026-07-26T10:33:15.866381Z","steps":["trace[477492513] 'read index received' (duration: 108.475054ms)","trace[477492513] 'applied index is now lower than readState.Index' (duration: 200.264µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:33:15.866559Z","caller":"traceutil/trace.go:171","msg":"trace[1416974203] transaction","detail":"{read_only:false; response_revision:4294; number_of_response:1; }","duration":"173.877043ms","start":"2026-07-26T10:33:15.692632Z","end":"2026-07-26T10:33:15.866509Z","steps":["trace[1416974203] 'process raft request' (duration: 173.604528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:33:15.866617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.887942ms","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-07-26T10:33:15.866658Z","caller":"traceutil/trace.go:171","msg":"trace[1908591784] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4294; }","duration":"108.977143ms","start":"2026-07-26T10:33:15.75767Z","end":"2026-07-26T10:33:15.866647Z","steps":["trace[1908591784] 'agreement among raft nodes before linearized reading' (duration: 108.82633ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:33:16.078282Z","caller":"traceutil/trace.go:171","msg":"trace[1333910611] transaction","detail":"{read_only:false; response_revision:4295; number_of_response:1; }","duration":"207.58537ms","start":"2026-07-26T10:33:15.870669Z","end":"2026-07-26T10:33:16.078254Z","steps":["trace[1333910611] 'process raft request' (duration: 149.525583ms)","trace[1333910611] 'compare' (duration: 57.69061ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:33:16.078626Z","caller":"traceutil/trace.go:171","msg":"trace[1354943068] transaction","detail":"{read_only:false; response_revision:4296; number_of_response:1; }","duration":"207.302695ms","start":"2026-07-26T10:33:15.871308Z","end":"2026-07-26T10:33:16.07861Z","steps":["trace[1354943068] 'process raft request' (duration: 206.895566ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:33:16.0787Z","caller":"traceutil/trace.go:171","msg":"trace[1238190961] transaction","detail":"{read_only:false; response_revision:4297; number_of_response:1; }","duration":"207.044819ms","start":"2026-07-26T10:33:15.87161Z","end":"2026-07-26T10:33:16.078655Z","steps":["trace[1238190961] 'process raft request' (duration: 206.842334ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:33:44.002809Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2930} {"level":"warn","ts":"2026-07-26T10:33:44.178514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.548368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T10:33:44.178691Z","caller":"traceutil/trace.go:171","msg":"trace[444392674] linearizableReadLoop","detail":"{readStateIndex:4737; appliedIndex:4736; }","duration":"106.788658ms","start":"2026-07-26T10:33:44.071877Z","end":"2026-07-26T10:33:44.178666Z","steps":["trace[444392674] 'read index received' (duration: 48.981µs)","trace[444392674] 'applied index is now lower than readState.Index' (duration: 106.737837ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:33:44.17878Z","caller":"traceutil/trace.go:171","msg":"trace[1956764880] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"171.310571ms","start":"2026-07-26T10:33:44.007423Z","end":"2026-07-26T10:33:44.178734Z","steps":["trace[1956764880] 'process raft request' (duration: 37.397504ms)","trace[1956764880] 'compare' (duration: 64.539223ms)","trace[1956764880] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 68.801931ms)"],"step_count":3} {"level":"warn","ts":"2026-07-26T10:33:44.178931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.060194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-07-26T10:33:44.179006Z","caller":"traceutil/trace.go:171","msg":"trace[1801037159] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:4564; }","duration":"107.164136ms","start":"2026-07-26T10:33:44.071829Z","end":"2026-07-26T10:33:44.178993Z","steps":["trace[1801037159] 'agreement among raft nodes before linearized reading' (duration: 106.917491ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:33:44.347423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2930,"took":"343.234023ms","hash":2216049162,"current-db-size-bytes":38506496,"current-db-size":"38 MB","current-db-size-in-use-bytes":11599872,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-07-26T10:33:44.347508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2216049162,"revision":2930,"compact-revision":-1} {"level":"info","ts":"2026-07-26T10:33:49.978355Z","caller":"traceutil/trace.go:171","msg":"trace[1213541052] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"127.943111ms","start":"2026-07-26T10:33:49.850368Z","end":"2026-07-26T10:33:49.978311Z","steps":["trace[1213541052] 'process raft request' (duration: 127.564623ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:38:44.009398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4563} {"level":"info","ts":"2026-07-26T10:38:44.049084Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4563,"took":"38.311357ms","hash":1346157486,"current-db-size-bytes":38506496,"current-db-size":"38 MB","current-db-size-in-use-bytes":19062784,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-26T10:38:44.049196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1346157486,"revision":4563,"compact-revision":2930} {"level":"info","ts":"2026-07-26T10:42:32.473093Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002693.wal"} {"level":"info","ts":"2026-07-26T10:42:33.870259Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5a9e84e0e0a90b63","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T10:42:33.875092Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-26T10:42:33.875236Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-26T10:43:44.015175Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7125} {"level":"info","ts":"2026-07-26T10:43:44.087767Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7125,"took":"70.165173ms","hash":3310894909,"current-db-size-bytes":47329280,"current-db-size":"47 MB","current-db-size-in-use-bytes":41439232,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-07-26T10:43:44.087835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3310894909,"revision":7125,"compact-revision":4563} {"level":"info","ts":"2026-07-26T10:48:44.02139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10834} {"level":"info","ts":"2026-07-26T10:48:44.157381Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10834,"took":"132.200895ms","hash":3245595282,"current-db-size-bytes":61784064,"current-db-size":"62 MB","current-db-size-in-use-bytes":39485440,"current-db-size-in-use":"40 MB"} {"level":"info","ts":"2026-07-26T10:48:44.157466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3245595282,"revision":10834,"compact-revision":7125} {"level":"info","ts":"2026-07-26T10:51:50.738675Z","caller":"traceutil/trace.go:171","msg":"trace[2137095084] transaction","detail":"{read_only:false; response_revision:17787; number_of_response:1; }","duration":"105.916499ms","start":"2026-07-26T10:51:50.632725Z","end":"2026-07-26T10:51:50.738642Z","steps":["trace[2137095084] 'process raft request' (duration: 105.739525ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:50.766843Z","caller":"traceutil/trace.go:171","msg":"trace[1650127379] transaction","detail":"{read_only:false; response_revision:17788; number_of_response:1; }","duration":"111.160006ms","start":"2026-07-26T10:51:50.655655Z","end":"2026-07-26T10:51:50.766815Z","steps":["trace[1650127379] 'process raft request' (duration: 110.984463ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:50.965671Z","caller":"traceutil/trace.go:171","msg":"trace[779887454] linearizableReadLoop","detail":"{readStateIndex:18312; appliedIndex:18311; }","duration":"188.031408ms","start":"2026-07-26T10:51:50.777618Z","end":"2026-07-26T10:51:50.965649Z","steps":["trace[779887454] 'read index received' (duration: 183.623878ms)","trace[779887454] 'applied index is now lower than readState.Index' (duration: 4.40663ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:51:50.965741Z","caller":"traceutil/trace.go:171","msg":"trace[1845020063] transaction","detail":"{read_only:false; response_revision:17790; number_of_response:1; }","duration":"208.55731ms","start":"2026-07-26T10:51:50.75716Z","end":"2026-07-26T10:51:50.965717Z","steps":["trace[1845020063] 'process raft request' (duration: 204.154611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:51:50.965851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.212613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-26T10:51:50.965888Z","caller":"traceutil/trace.go:171","msg":"trace[2063094464] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:17790; }","duration":"188.309615ms","start":"2026-07-26T10:51:50.777568Z","end":"2026-07-26T10:51:50.965877Z","steps":["trace[2063094464] 'agreement among raft nodes before linearized reading' (duration: 188.190502ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:51.439702Z","caller":"traceutil/trace.go:171","msg":"trace[600805025] transaction","detail":"{read_only:false; response_revision:17792; number_of_response:1; }","duration":"153.269763ms","start":"2026-07-26T10:51:51.286401Z","end":"2026-07-26T10:51:51.439671Z","steps":["trace[600805025] 'process raft request' (duration: 95.77375ms)","trace[600805025] 'compare' (duration: 57.269799ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:51:51.440112Z","caller":"traceutil/trace.go:171","msg":"trace[540727450] transaction","detail":"{read_only:false; response_revision:17793; number_of_response:1; }","duration":"142.479632ms","start":"2026-07-26T10:51:51.297619Z","end":"2026-07-26T10:51:51.440098Z","steps":["trace[540727450] 'process raft request' (duration: 141.996792ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:51.440083Z","caller":"traceutil/trace.go:171","msg":"trace[2089807519] transaction","detail":"{read_only:false; response_revision:17794; number_of_response:1; }","duration":"125.253127ms","start":"2026-07-26T10:51:51.31479Z","end":"2026-07-26T10:51:51.440043Z","steps":["trace[2089807519] 'process raft request' (duration: 125.122404ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:51.739449Z","caller":"traceutil/trace.go:171","msg":"trace[1880642952] transaction","detail":"{read_only:false; response_revision:17795; number_of_response:1; }","duration":"127.001144ms","start":"2026-07-26T10:51:51.612186Z","end":"2026-07-26T10:51:51.739187Z","steps":["trace[1880642952] 'process raft request' (duration: 126.715347ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:51:51.74481Z","caller":"traceutil/trace.go:171","msg":"trace[258564331] transaction","detail":"{read_only:false; response_revision:17796; number_of_response:1; }","duration":"120.779876ms","start":"2026-07-26T10:51:51.62402Z","end":"2026-07-26T10:51:51.7448Z","steps":["trace[258564331] 'process raft request' (duration: 120.511831ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:52:34.228552Z","caller":"traceutil/trace.go:171","msg":"trace[1560829994] linearizableReadLoop","detail":"{readStateIndex:18845; appliedIndex:18844; }","duration":"187.394344ms","start":"2026-07-26T10:52:34.041125Z","end":"2026-07-26T10:52:34.228519Z","steps":["trace[1560829994] 'read index received' (duration: 186.193619ms)","trace[1560829994] 'applied index is now lower than readState.Index' (duration: 1.199184ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:52:34.228686Z","caller":"traceutil/trace.go:171","msg":"trace[794580873] transaction","detail":"{read_only:false; response_revision:18312; number_of_response:1; }","duration":"193.890046ms","start":"2026-07-26T10:52:34.03472Z","end":"2026-07-26T10:52:34.22861Z","steps":["trace[794580873] 'process raft request' (duration: 192.552539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:52:34.228825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.557648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-26T10:52:34.228877Z","caller":"traceutil/trace.go:171","msg":"trace[1475072493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18312; }","duration":"189.66875ms","start":"2026-07-26T10:52:34.039194Z","end":"2026-07-26T10:52:34.228863Z","steps":["trace[1475072493] 'agreement among raft nodes before linearized reading' (duration: 189.475807ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:52:34.510962Z","caller":"traceutil/trace.go:171","msg":"trace[937634774] transaction","detail":"{read_only:false; response_revision:18315; number_of_response:1; }","duration":"144.419963ms","start":"2026-07-26T10:52:34.3665Z","end":"2026-07-26T10:52:34.51092Z","steps":["trace[937634774] 'process raft request' (duration: 80.213866ms)","trace[937634774] 'compare' (duration: 63.629025ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:53:44.027496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14692} {"level":"info","ts":"2026-07-26T10:53:44.174945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14692,"took":"138.364638ms","hash":1393428516,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":52793344,"current-db-size-in-use":"53 MB"} {"level":"info","ts":"2026-07-26T10:53:44.175011Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1393428516,"revision":14692,"compact-revision":10834} {"level":"info","ts":"2026-07-26T10:53:50.380945Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5a9e84e0e0a90b63","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T10:53:50.386208Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-26T10:53:50.386293Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-26T10:54:16.946369Z","caller":"traceutil/trace.go:171","msg":"trace[478455169] transaction","detail":"{read_only:false; response_revision:19667; number_of_response:1; }","duration":"103.216317ms","start":"2026-07-26T10:54:16.843122Z","end":"2026-07-26T10:54:16.946338Z","steps":["trace[478455169] 'process raft request' (duration: 103.051034ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:17.015144Z","caller":"traceutil/trace.go:171","msg":"trace[1564811293] linearizableReadLoop","detail":"{readStateIndex:20241; appliedIndex:20239; }","duration":"129.830233ms","start":"2026-07-26T10:54:16.885281Z","end":"2026-07-26T10:54:17.015111Z","steps":["trace[1564811293] 'read index received' (duration: 61.568923ms)","trace[1564811293] 'applied index is now lower than readState.Index' (duration: 68.2598ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:54:17.015672Z","caller":"traceutil/trace.go:171","msg":"trace[607411989] transaction","detail":"{read_only:false; response_revision:19668; number_of_response:1; }","duration":"169.393385ms","start":"2026-07-26T10:54:16.846261Z","end":"2026-07-26T10:54:17.015655Z","steps":["trace[607411989] 'process raft request' (duration: 168.668799ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:17.015935Z","caller":"traceutil/trace.go:171","msg":"trace[1842926203] transaction","detail":"{read_only:false; response_revision:19669; number_of_response:1; }","duration":"146.801001ms","start":"2026-07-26T10:54:16.869121Z","end":"2026-07-26T10:54:17.015922Z","steps":["trace[1842926203] 'process raft request' (duration: 145.939064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T10:54:17.016378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.059908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-26T10:54:17.016486Z","caller":"traceutil/trace.go:171","msg":"trace[2040804700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19669; }","duration":"131.222471ms","start":"2026-07-26T10:54:16.885236Z","end":"2026-07-26T10:54:17.016459Z","steps":["trace[2040804700] 'agreement among raft nodes before linearized reading' (duration: 130.942786ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:17.32165Z","caller":"traceutil/trace.go:171","msg":"trace[1408891618] transaction","detail":"{read_only:false; response_revision:19675; number_of_response:1; }","duration":"151.781783ms","start":"2026-07-26T10:54:17.16984Z","end":"2026-07-26T10:54:17.321622Z","steps":["trace[1408891618] 'process raft request' (duration: 151.717772ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:17.322106Z","caller":"traceutil/trace.go:171","msg":"trace[2099742900] transaction","detail":"{read_only:false; response_revision:19673; number_of_response:1; }","duration":"158.007531ms","start":"2026-07-26T10:54:17.164083Z","end":"2026-07-26T10:54:17.322091Z","steps":["trace[2099742900] 'process raft request' (duration: 78.417059ms)","trace[2099742900] 'compare' (duration: 78.804986ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:54:17.32225Z","caller":"traceutil/trace.go:171","msg":"trace[1727162165] transaction","detail":"{read_only:false; response_revision:19674; number_of_response:1; }","duration":"156.429679ms","start":"2026-07-26T10:54:17.165811Z","end":"2026-07-26T10:54:17.32224Z","steps":["trace[1727162165] 'process raft request' (duration: 155.679063ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:17.578521Z","caller":"traceutil/trace.go:171","msg":"trace[1525566688] transaction","detail":"{read_only:false; response_revision:19677; number_of_response:1; }","duration":"162.203116ms","start":"2026-07-26T10:54:17.416285Z","end":"2026-07-26T10:54:17.578489Z","steps":["trace[1525566688] 'process raft request' (duration: 162.027483ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:18.293577Z","caller":"traceutil/trace.go:171","msg":"trace[1496337524] transaction","detail":"{read_only:false; response_revision:19680; number_of_response:1; }","duration":"213.214872ms","start":"2026-07-26T10:54:18.080323Z","end":"2026-07-26T10:54:18.293538Z","steps":["trace[1496337524] 'process raft request' (duration: 213.065109ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:54:18.293777Z","caller":"traceutil/trace.go:171","msg":"trace[382374874] transaction","detail":"{read_only:false; response_revision:19679; number_of_response:1; }","duration":"217.773986ms","start":"2026-07-26T10:54:18.075908Z","end":"2026-07-26T10:54:18.293682Z","steps":["trace[382374874] 'process raft request' (duration: 203.263619ms)","trace[382374874] 'compare' (duration: 14.034918ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T10:54:18.301435Z","caller":"traceutil/trace.go:171","msg":"trace[1446228977] transaction","detail":"{read_only:false; response_revision:19681; number_of_response:1; }","duration":"126.005715ms","start":"2026-07-26T10:54:18.175385Z","end":"2026-07-26T10:54:18.301391Z","steps":["trace[1446228977] 'process raft request' (duration: 125.883762ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T10:58:44.035904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19363} {"level":"info","ts":"2026-07-26T10:58:44.205065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19363,"took":"164.600887ms","hash":1965251204,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":38522880,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-26T10:58:44.205124Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1965251204,"revision":19363,"compact-revision":14692} {"level":"info","ts":"2026-07-26T11:03:44.052927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22251} {"level":"info","ts":"2026-07-26T11:03:44.1933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22251,"took":"136.242129ms","hash":2815084420,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":31670272,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-26T11:03:44.193385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2815084420,"revision":22251,"compact-revision":19363} {"level":"info","ts":"2026-07-26T11:06:27.175942Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067ba.wal"} {"level":"info","ts":"2026-07-26T11:08:44.067878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24546} {"level":"info","ts":"2026-07-26T11:08:44.18428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24546,"took":"112.458716ms","hash":1164140014,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":32256000,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-26T11:08:44.184359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1164140014,"revision":24546,"compact-revision":22251} {"level":"info","ts":"2026-07-26T11:13:44.081249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26822} {"level":"info","ts":"2026-07-26T11:13:44.350383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26822,"took":"262.799957ms","hash":3811643507,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":33923072,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-26T11:13:44.350437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3811643507,"revision":26822,"compact-revision":24546} {"level":"info","ts":"2026-07-26T11:13:49.68119Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5a9e84e0e0a90b63","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T11:13:49.687186Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-26T11:13:49.687346Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-26T11:18:44.087661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29134} {"level":"info","ts":"2026-07-26T11:18:44.225832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29134,"took":"132.68483ms","hash":2870989623,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":32780288,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-26T11:18:44.225969Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2870989623,"revision":29134,"compact-revision":26822} {"level":"info","ts":"2026-07-26T11:23:44.094126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31357} {"level":"info","ts":"2026-07-26T11:23:44.216809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31357,"took":"114.318354ms","hash":1589717025,"current-db-size-bytes":66547712,"current-db-size":"66 MB","current-db-size-in-use-bytes":33718272,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-26T11:23:44.216875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1589717025,"revision":31357,"compact-revision":29134}