{"level":"warn","ts":"2026-05-27T00:38:42.787115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:38:42.787198Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.137:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.137:2380","--initial-cluster=instance=https://199.19.213.137:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.137:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.137: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-05-27T00:38:42.787496Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:38:42.787513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-05-27T00:38:42.787529Z","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-05-27T00:38:42.788213Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"]} {"level":"info","ts":"2026-05-27T00:38:42.788304Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.137: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-05-27T00:38:42.79647Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.971238ms"} {"level":"info","ts":"2026-05-27T00:38:42.805391Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2ba8e3c2b0588654","cluster-id":"97694c3f9947e4ca"} {"level":"info","ts":"2026-05-27T00:38:42.80548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T00:38:42.805501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 0"} {"level":"info","ts":"2026-05-27T00:38:42.805515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2ba8e3c2b0588654 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T00:38:42.805544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 1"} {"level":"info","ts":"2026-05-27T00:38:42.805582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"warn","ts":"2026-05-27T00:38:42.812735Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T00:38:42.814228Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T00:38:42.815524Z","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-05-27T00:38:42.818588Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2ba8e3c2b0588654","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T00:38:42.820506Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2ba8e3c2b0588654","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T00:38:42.82076Z","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-05-27T00:38:42.82079Z","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-05-27T00:38:42.820809Z","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-05-27T00:38:42.822007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"info","ts":"2026-05-27T00:38:42.822819Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","added-peer-id":"2ba8e3c2b0588654","added-peer-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-05-27T00:38:42.825739Z","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-05-27T00:38:42.825854Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-05-27T00:38:42.82591Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-05-27T00:38:42.826113Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2ba8e3c2b0588654","initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T00:38:42.826153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T00:38:43.006322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T00:38:43.006384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T00:38:43.006409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgPreVoteResp from 2ba8e3c2b0588654 at term 1"} {"level":"info","ts":"2026-05-27T00:38:43.006429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became candidate at term 2"} {"level":"info","ts":"2026-05-27T00:38:43.006467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgVoteResp from 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-05-27T00:38:43.006488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became leader at term 2"} {"level":"info","ts":"2026-05-27T00:38:43.006507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2ba8e3c2b0588654 elected leader 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-05-27T00:38:43.007398Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:38:43.008191Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:38:43.008209Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2ba8e3c2b0588654","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.137:2379]}","request-path":"/0/members/2ba8e3c2b0588654/attributes","cluster-id":"97694c3f9947e4ca","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T00:38:43.008313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:38:43.008475Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:38:43.008614Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:38:43.008659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:38:43.00873Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T00:38:43.008813Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T00:38:43.011092Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.137:2379"} {"level":"info","ts":"2026-05-27T00:38:43.012212Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T00:39:20.584465Z","caller":"traceutil/trace.go:171","msg":"trace[1988934681] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"145.452624ms","start":"2026-05-27T00:39:20.438991Z","end":"2026-05-27T00:39:20.584443Z","steps":["trace[1988934681] 'process raft request' (duration: 145.349532ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.592462Z","caller":"traceutil/trace.go:171","msg":"trace[1900530254] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"152.913143ms","start":"2026-05-27T00:39:20.439522Z","end":"2026-05-27T00:39:20.592435Z","steps":["trace[1900530254] 'process raft request' (duration: 152.7708ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.592505Z","caller":"traceutil/trace.go:171","msg":"trace[1782163661] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"146.994991ms","start":"2026-05-27T00:39:20.445491Z","end":"2026-05-27T00:39:20.592486Z","steps":["trace[1782163661] 'process raft request' (duration: 146.893899ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.59264Z","caller":"traceutil/trace.go:171","msg":"trace[382483608] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"141.618048ms","start":"2026-05-27T00:39:20.451005Z","end":"2026-05-27T00:39:20.592623Z","steps":["trace[382483608] 'process raft request' (duration: 141.465946ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.5927Z","caller":"traceutil/trace.go:171","msg":"trace[170225002] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"147.048132ms","start":"2026-05-27T00:39:20.445552Z","end":"2026-05-27T00:39:20.5926Z","steps":["trace[170225002] 'process raft request' (duration: 146.880439ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.59276Z","caller":"traceutil/trace.go:171","msg":"trace[1014949622] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"137.673ms","start":"2026-05-27T00:39:20.455053Z","end":"2026-05-27T00:39:20.592725Z","steps":["trace[1014949622] 'process raft request' (duration: 137.466256ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.592915Z","caller":"traceutil/trace.go:171","msg":"trace[2104012878] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"137.833052ms","start":"2026-05-27T00:39:20.455074Z","end":"2026-05-27T00:39:20.592907Z","steps":["trace[2104012878] 'process raft request' (duration: 137.653039ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.592964Z","caller":"traceutil/trace.go:171","msg":"trace[1254584483] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"137.408215ms","start":"2026-05-27T00:39:20.455539Z","end":"2026-05-27T00:39:20.592947Z","steps":["trace[1254584483] 'process raft request' (duration: 137.307043ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.593082Z","caller":"traceutil/trace.go:171","msg":"trace[592715474] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"134.280412ms","start":"2026-05-27T00:39:20.458785Z","end":"2026-05-27T00:39:20.593065Z","steps":["trace[592715474] 'process raft request' (duration: 134.109449ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.593152Z","caller":"traceutil/trace.go:171","msg":"trace[1036488999] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"109.241141ms","start":"2026-05-27T00:39:20.483885Z","end":"2026-05-27T00:39:20.593126Z","steps":["trace[1036488999] 'process raft request' (duration: 109.142469ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:20.593207Z","caller":"traceutil/trace.go:171","msg":"trace[110126690] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"130.343573ms","start":"2026-05-27T00:39:20.462805Z","end":"2026-05-27T00:39:20.593149Z","steps":["trace[110126690] 'process raft request' (duration: 130.16746ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.022846Z","caller":"traceutil/trace.go:171","msg":"trace[311485439] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"108.497283ms","start":"2026-05-27T00:39:26.914317Z","end":"2026-05-27T00:39:27.022814Z","steps":["trace[311485439] 'process raft request' (duration: 108.224639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:27.228647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.68316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:39:27.228808Z","caller":"traceutil/trace.go:171","msg":"trace[748362167] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"194.51349ms","start":"2026-05-27T00:39:27.034277Z","end":"2026-05-27T00:39:27.228791Z","steps":["trace[748362167] 'read index received' (duration: 9.274494ms)","trace[748362167] 'applied index is now lower than readState.Index' (duration: 185.237246ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:39:27.228902Z","caller":"traceutil/trace.go:171","msg":"trace[20451798] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"202.897679ms","start":"2026-05-27T00:39:27.025992Z","end":"2026-05-27T00:39:27.22889Z","steps":["trace[20451798] 'process raft request' (duration: 17.623382ms)","trace[20451798] 'compare' (duration: 183.562078ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:39:27.229182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.920286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-27T00:39:27.22925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.931287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T00:39:27.229318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.191937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T00:39:27.229484Z","caller":"traceutil/trace.go:171","msg":"trace[1128881266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"167.373931ms","start":"2026-05-27T00:39:27.062097Z","end":"2026-05-27T00:39:27.229471Z","steps":["trace[1128881266] 'agreement among raft nodes before linearized reading' (duration: 167.102277ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.229395Z","caller":"traceutil/trace.go:171","msg":"trace[1477804496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"195.11112ms","start":"2026-05-27T00:39:27.034239Z","end":"2026-05-27T00:39:27.229351Z","steps":["trace[1477804496] 'agreement among raft nodes before linearized reading' (duration: 194.846426ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.22925Z","caller":"traceutil/trace.go:171","msg":"trace[1457282299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"181.052997ms","start":"2026-05-27T00:39:27.04818Z","end":"2026-05-27T00:39:27.229233Z","steps":["trace[1457282299] 'agreement among raft nodes before linearized reading' (duration: 180.846454ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.378855Z","caller":"traceutil/trace.go:171","msg":"trace[1568040887] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"139.711382ms","start":"2026-05-27T00:39:27.23912Z","end":"2026-05-27T00:39:27.378831Z","steps":["trace[1568040887] 'process raft request' (duration: 139.550999ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.607954Z","caller":"traceutil/trace.go:171","msg":"trace[646523724] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"365.086683ms","start":"2026-05-27T00:39:27.242837Z","end":"2026-05-27T00:39:27.607924Z","steps":["trace[646523724] 'process raft request' (duration: 364.801098ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:27.608026Z","caller":"traceutil/trace.go:171","msg":"trace[1537797567] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"365.095233ms","start":"2026-05-27T00:39:27.242905Z","end":"2026-05-27T00:39:27.608001Z","steps":["trace[1537797567] 'process raft request' (duration: 364.89779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:27.608114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:39:27.242877Z","time spent":"365.186164ms","remote":"127.0.0.1:56304","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-05-27T00:39:27.60812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:39:27.242807Z","time spent":"365.228925ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:39:27.612504Z","caller":"traceutil/trace.go:171","msg":"trace[705208606] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"364.145578ms","start":"2026-05-27T00:39:27.248332Z","end":"2026-05-27T00:39:27.612477Z","steps":["trace[705208606] 'process raft request' (duration: 359.713564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:27.612712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:39:27.248312Z","time spent":"364.271199ms","remote":"127.0.0.1:56166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:39:28.29191Z","caller":"traceutil/trace.go:171","msg":"trace[596510310] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"623.728418ms","start":"2026-05-27T00:39:27.668156Z","end":"2026-05-27T00:39:28.291885Z","steps":["trace[596510310] 'process raft request' (duration: 623.580766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:28.292037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:39:27.668126Z","time spent":"623.85521ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T00:39:43.382507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.54284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:39:43.382602Z","caller":"traceutil/trace.go:171","msg":"trace[44472044] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:759; }","duration":"108.729342ms","start":"2026-05-27T00:39:43.273854Z","end":"2026-05-27T00:39:43.382584Z","steps":["trace[44472044] 'count revisions from in-memory index tree' (duration: 108.367517ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:43.569429Z","caller":"traceutil/trace.go:171","msg":"trace[483155719] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"183.147749ms","start":"2026-05-27T00:39:43.386265Z","end":"2026-05-27T00:39:43.569412Z","steps":["trace[483155719] 'process raft request' (duration: 182.718343ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.153318Z","caller":"traceutil/trace.go:171","msg":"trace[445800858] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"112.128416ms","start":"2026-05-27T00:39:51.041143Z","end":"2026-05-27T00:39:51.153271Z","steps":["trace[445800858] 'process raft request' (duration: 111.934683ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.263184Z","caller":"traceutil/trace.go:171","msg":"trace[428857579] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"104.780396ms","start":"2026-05-27T00:39:51.158377Z","end":"2026-05-27T00:39:51.263157Z","steps":["trace[428857579] 'process raft request' (duration: 104.237369ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.267256Z","caller":"traceutil/trace.go:171","msg":"trace[1519469368] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"108.830707ms","start":"2026-05-27T00:39:51.158389Z","end":"2026-05-27T00:39:51.26722Z","steps":["trace[1519469368] 'process raft request' (duration: 108.634694ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.267329Z","caller":"traceutil/trace.go:171","msg":"trace[329638583] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"105.123603ms","start":"2026-05-27T00:39:51.162183Z","end":"2026-05-27T00:39:51.267306Z","steps":["trace[329638583] 'process raft request' (duration: 104.92376ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.267642Z","caller":"traceutil/trace.go:171","msg":"trace[1659937089] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"102.138747ms","start":"2026-05-27T00:39:51.16546Z","end":"2026-05-27T00:39:51.267599Z","steps":["trace[1659937089] 'process raft request' (duration: 101.707351ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.47635Z","caller":"traceutil/trace.go:171","msg":"trace[2042036074] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"117.608256ms","start":"2026-05-27T00:39:51.358698Z","end":"2026-05-27T00:39:51.476306Z","steps":["trace[2042036074] 'process raft request' (duration: 117.373762ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.476374Z","caller":"traceutil/trace.go:171","msg":"trace[1463099561] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"116.762424ms","start":"2026-05-27T00:39:51.359581Z","end":"2026-05-27T00:39:51.476344Z","steps":["trace[1463099561] 'process raft request' (duration: 116.597101ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.476406Z","caller":"traceutil/trace.go:171","msg":"trace[1081861476] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"117.867552ms","start":"2026-05-27T00:39:51.358515Z","end":"2026-05-27T00:39:51.476382Z","steps":["trace[1081861476] 'process raft request' (duration: 117.519516ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.476462Z","caller":"traceutil/trace.go:171","msg":"trace[1268250423] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"116.832595ms","start":"2026-05-27T00:39:51.359592Z","end":"2026-05-27T00:39:51.476425Z","steps":["trace[1268250423] 'process raft request' (duration: 116.633041ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.476647Z","caller":"traceutil/trace.go:171","msg":"trace[1231459566] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"119.24617ms","start":"2026-05-27T00:39:51.356937Z","end":"2026-05-27T00:39:51.476183Z","steps":["trace[1231459566] 'process raft request' (duration: 118.971396ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.485679Z","caller":"traceutil/trace.go:171","msg":"trace[1666646313] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:900; }","duration":"127.183298ms","start":"2026-05-27T00:39:51.358472Z","end":"2026-05-27T00:39:51.485656Z","steps":["trace[1666646313] 'read index received' (duration: 45.982399ms)","trace[1666646313] 'applied index is now lower than readState.Index' (duration: 81.199899ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:39:51.485839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.35423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-8h56p\" ","response":"range_response_count:1 size:4878"} {"level":"info","ts":"2026-05-27T00:39:51.485882Z","caller":"traceutil/trace.go:171","msg":"trace[1361475334] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-8h56p; range_end:; response_count:1; response_revision:875; }","duration":"127.489012ms","start":"2026-05-27T00:39:51.358383Z","end":"2026-05-27T00:39:51.485872Z","steps":["trace[1361475334] 'agreement among raft nodes before linearized reading' (duration: 127.34339ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.631023Z","caller":"traceutil/trace.go:171","msg":"trace[435433115] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"101.830094ms","start":"2026-05-27T00:39:51.529164Z","end":"2026-05-27T00:39:51.630994Z","steps":["trace[435433115] 'process raft request' (duration: 99.947506ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:51.963209Z","caller":"traceutil/trace.go:171","msg":"trace[1669130436] linearizableReadLoop","detail":"{readStateIndex:914; appliedIndex:913; }","duration":"106.492523ms","start":"2026-05-27T00:39:51.856692Z","end":"2026-05-27T00:39:51.963184Z","steps":["trace[1669130436] 'read index received' (duration: 105.811633ms)","trace[1669130436] 'applied index is now lower than readState.Index' (duration: 679.97µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:39:51.963285Z","caller":"traceutil/trace.go:171","msg":"trace[1046077591] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"230.28861ms","start":"2026-05-27T00:39:51.732969Z","end":"2026-05-27T00:39:51.963258Z","steps":["trace[1046077591] 'process raft request' (duration: 229.892944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:51.963363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.661835ms","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-05-27T00:39:51.963413Z","caller":"traceutil/trace.go:171","msg":"trace[1234217303] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:881; }","duration":"106.776097ms","start":"2026-05-27T00:39:51.856612Z","end":"2026-05-27T00:39:51.963388Z","steps":["trace[1234217303] 'agreement among raft nodes before linearized reading' (duration: 106.695976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:52.191036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.497925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:39:52.191142Z","caller":"traceutil/trace.go:171","msg":"trace[1278903953] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:882; }","duration":"127.652128ms","start":"2026-05-27T00:39:52.063465Z","end":"2026-05-27T00:39:52.191117Z","steps":["trace[1278903953] 'range keys from in-memory index tree' (duration: 127.432915ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:53.364066Z","caller":"traceutil/trace.go:171","msg":"trace[735698807] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"193.102188ms","start":"2026-05-27T00:39:53.170935Z","end":"2026-05-27T00:39:53.364037Z","steps":["trace[735698807] 'process raft request' (duration: 192.938505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:39:56.627133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.956507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:39:56.627206Z","caller":"traceutil/trace.go:171","msg":"trace[1148863781] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"196.96982ms","start":"2026-05-27T00:39:56.430226Z","end":"2026-05-27T00:39:56.627195Z","steps":["trace[1148863781] 'read index received' (duration: 49.810961ms)","trace[1148863781] 'applied index is now lower than readState.Index' (duration: 147.158129ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:39:56.627255Z","caller":"traceutil/trace.go:171","msg":"trace[1174156244] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"243.352842ms","start":"2026-05-27T00:39:56.383896Z","end":"2026-05-27T00:39:56.627249Z","steps":["trace[1174156244] 'process raft request' (duration: 96.226683ms)","trace[1174156244] 'compare' (duration: 146.800574ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:39:56.627611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.354906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-sbfxr\" ","response":"range_response_count:1 size:5674"} {"level":"info","ts":"2026-05-27T00:39:56.627686Z","caller":"traceutil/trace.go:171","msg":"trace[731869326] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-sbfxr; range_end:; response_count:1; response_revision:924; }","duration":"197.466257ms","start":"2026-05-27T00:39:56.430202Z","end":"2026-05-27T00:39:56.627668Z","steps":["trace[731869326] 'agreement among raft nodes before linearized reading' (duration: 197.220234ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:56.893515Z","caller":"traceutil/trace.go:171","msg":"trace[1532825712] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"257.678519ms","start":"2026-05-27T00:39:56.635792Z","end":"2026-05-27T00:39:56.89347Z","steps":["trace[1532825712] 'process raft request' (duration: 257.445055ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:57.077484Z","caller":"traceutil/trace.go:171","msg":"trace[994924217] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"175.501005ms","start":"2026-05-27T00:39:56.901965Z","end":"2026-05-27T00:39:57.077466Z","steps":["trace[994924217] 'process raft request' (duration: 175.427974ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:39:57.077555Z","caller":"traceutil/trace.go:171","msg":"trace[1762165547] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"177.555424ms","start":"2026-05-27T00:39:56.899966Z","end":"2026-05-27T00:39:57.077521Z","steps":["trace[1762165547] 'process raft request' (duration: 171.411765ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:06.247162Z","caller":"traceutil/trace.go:171","msg":"trace[816065264] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"117.708091ms","start":"2026-05-27T00:40:06.129426Z","end":"2026-05-27T00:40:06.247134Z","steps":["trace[816065264] 'process raft request' (duration: 117.522199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:07.315366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.661185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:40:07.315604Z","caller":"traceutil/trace.go:171","msg":"trace[438994082] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"193.372917ms","start":"2026-05-27T00:40:07.122196Z","end":"2026-05-27T00:40:07.315569Z","steps":["trace[438994082] 'process raft request' (duration: 65.425539ms)","trace[438994082] 'compare' (duration: 127.530512ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:40:07.31566Z","caller":"traceutil/trace.go:171","msg":"trace[88282139] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"193.083043ms","start":"2026-05-27T00:40:07.12256Z","end":"2026-05-27T00:40:07.315643Z","steps":["trace[88282139] 'process raft request' (duration: 192.943842ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:07.600796Z","caller":"traceutil/trace.go:171","msg":"trace[1930463235] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"191.109656ms","start":"2026-05-27T00:40:07.409659Z","end":"2026-05-27T00:40:07.600768Z","steps":["trace[1930463235] 'process raft request' (duration: 190.220994ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:09.480964Z","caller":"traceutil/trace.go:171","msg":"trace[1122679809] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"125.953679ms","start":"2026-05-27T00:40:09.354987Z","end":"2026-05-27T00:40:09.480941Z","steps":["trace[1122679809] 'read index received' (duration: 114.029254ms)","trace[1122679809] 'applied index is now lower than readState.Index' (duration: 11.923525ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:40:09.481023Z","caller":"traceutil/trace.go:171","msg":"trace[1087632864] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"213.533898ms","start":"2026-05-27T00:40:09.267437Z","end":"2026-05-27T00:40:09.480971Z","steps":["trace[1087632864] 'process raft request' (duration: 201.658614ms)","trace[1087632864] 'compare' (duration: 11.747583ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:40:09.481092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.084821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:40:09.481157Z","caller":"traceutil/trace.go:171","msg":"trace[1327789481] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1138; }","duration":"126.189812ms","start":"2026-05-27T00:40:09.354949Z","end":"2026-05-27T00:40:09.481139Z","steps":["trace[1327789481] 'agreement among raft nodes before linearized reading' (duration: 126.08173ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:16.073926Z","caller":"traceutil/trace.go:171","msg":"trace[1017278442] linearizableReadLoop","detail":"{readStateIndex:1211; appliedIndex:1210; }","duration":"289.418246ms","start":"2026-05-27T00:40:15.784482Z","end":"2026-05-27T00:40:16.0739Z","steps":["trace[1017278442] 'read index received' (duration: 289.231124ms)","trace[1017278442] 'applied index is now lower than readState.Index' (duration: 185.702µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:40:16.074091Z","caller":"traceutil/trace.go:171","msg":"trace[879983554] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"441.439215ms","start":"2026-05-27T00:40:15.632636Z","end":"2026-05-27T00:40:16.074076Z","steps":["trace[879983554] 'process raft request' (duration: 441.043649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:16.074216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:40:15.63261Z","time spent":"441.521785ms","remote":"127.0.0.1:56304","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-05-27T00:40:16.074639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.377048ms","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-05-27T00:40:16.074744Z","caller":"traceutil/trace.go:171","msg":"trace[1424893561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1174; }","duration":"171.53384ms","start":"2026-05-27T00:40:15.903192Z","end":"2026-05-27T00:40:16.074726Z","steps":["trace[1424893561] 'agreement among raft nodes before linearized reading' (duration: 171.340118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:16.074728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.124232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:40:16.074992Z","caller":"traceutil/trace.go:171","msg":"trace[1209301709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1174; }","duration":"128.481646ms","start":"2026-05-27T00:40:15.946467Z","end":"2026-05-27T00:40:16.074948Z","steps":["trace[1209301709] 'agreement among raft nodes before linearized reading' (duration: 128.04259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:16.075043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.164018ms","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-05-27T00:40:16.075104Z","caller":"traceutil/trace.go:171","msg":"trace[948704954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1174; }","duration":"217.840437ms","start":"2026-05-27T00:40:15.857248Z","end":"2026-05-27T00:40:16.075089Z","steps":["trace[948704954] 'agreement among raft nodes before linearized reading' (duration: 217.007695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:16.07509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.616623ms","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-05-27T00:40:16.075272Z","caller":"traceutil/trace.go:171","msg":"trace[2126580207] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1174; }","duration":"290.836736ms","start":"2026-05-27T00:40:15.78442Z","end":"2026-05-27T00:40:16.075257Z","steps":["trace[2126580207] 'agreement among raft nodes before linearized reading' (duration: 290.581673ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:37.115256Z","caller":"traceutil/trace.go:171","msg":"trace[1540288603] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"214.798964ms","start":"2026-05-27T00:40:36.900418Z","end":"2026-05-27T00:40:37.115217Z","steps":["trace[1540288603] 'process raft request' (duration: 214.642502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:38.567135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.571307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:40:38.567237Z","caller":"traceutil/trace.go:171","msg":"trace[714877439] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"285.489245ms","start":"2026-05-27T00:40:38.281733Z","end":"2026-05-27T00:40:38.567222Z","steps":["trace[714877439] 'read index received' (duration: 134.648115ms)","trace[714877439] 'applied index is now lower than readState.Index' (duration: 150.8395ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:40:38.567336Z","caller":"traceutil/trace.go:171","msg":"trace[786795013] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"285.651246ms","start":"2026-05-27T00:40:38.281674Z","end":"2026-05-27T00:40:38.567325Z","steps":["trace[786795013] 'process raft request' (duration: 134.808646ms)","trace[786795013] 'compare' (duration: 150.340493ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:40:38.56744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.381048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:40:38.567537Z","caller":"traceutil/trace.go:171","msg":"trace[765698268] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1437; }","duration":"133.52513ms","start":"2026-05-27T00:40:38.433988Z","end":"2026-05-27T00:40:38.567513Z","steps":["trace[765698268] 'agreement among raft nodes before linearized reading' (duration: 133.350198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:38.567629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.88463ms","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-05-27T00:40:38.567675Z","caller":"traceutil/trace.go:171","msg":"trace[1458948352] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1437; }","duration":"285.979041ms","start":"2026-05-27T00:40:38.281683Z","end":"2026-05-27T00:40:38.567662Z","steps":["trace[1458948352] 'agreement among raft nodes before linearized reading' (duration: 285.833439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:40:38.567806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.174371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:40:38.567845Z","caller":"traceutil/trace.go:171","msg":"trace[1755532986] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1437; }","duration":"124.233603ms","start":"2026-05-27T00:40:38.4436Z","end":"2026-05-27T00:40:38.567834Z","steps":["trace[1755532986] 'agreement among raft nodes before linearized reading' (duration: 124.154052ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:40:55.976071Z","caller":"traceutil/trace.go:171","msg":"trace[1723390453] transaction","detail":"{read_only:false; response_revision:1737; number_of_response:1; }","duration":"107.825055ms","start":"2026-05-27T00:40:55.86822Z","end":"2026-05-27T00:40:55.976045Z","steps":["trace[1723390453] 'process raft request' (duration: 104.10908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:03.91371Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679535663783969747,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T00:41:03.963473Z","caller":"traceutil/trace.go:171","msg":"trace[2066642005] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"586.079019ms","start":"2026-05-27T00:41:03.377355Z","end":"2026-05-27T00:41:03.963434Z","steps":["trace[2066642005] 'process raft request' (duration: 585.852866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:03.963675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:03.377335Z","time spent":"586.23537ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:41:04.156191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.883727ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:41:04.156628Z","caller":"traceutil/trace.go:171","msg":"trace[629861734] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"558.575332ms","start":"2026-05-27T00:41:03.598028Z","end":"2026-05-27T00:41:04.156603Z","steps":["trace[629861734] 'process raft request' (duration: 412.176789ms)","trace[629861734] 'compare' (duration: 145.599323ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:04.156766Z","caller":"traceutil/trace.go:171","msg":"trace[1215553017] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1924; }","duration":"743.07925ms","start":"2026-05-27T00:41:03.413613Z","end":"2026-05-27T00:41:04.156693Z","steps":["trace[1215553017] 'read index received' (duration: 549.017829ms)","trace[1215553017] 'applied index is now lower than readState.Index' (duration: 194.059771ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:04.156939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:03.598006Z","time spent":"558.789684ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:41:04.157131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.509215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4b29b55-562a-40a5-aac9-58d876144933\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-27T00:41:04.157169Z","caller":"traceutil/trace.go:171","msg":"trace[2113494337] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e4b29b55-562a-40a5-aac9-58d876144933; range_end:; response_count:1; response_revision:1852; }","duration":"743.551475ms","start":"2026-05-27T00:41:03.413608Z","end":"2026-05-27T00:41:04.157159Z","steps":["trace[2113494337] 'agreement among raft nodes before linearized reading' (duration: 743.219012ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:04.157172Z","caller":"traceutil/trace.go:171","msg":"trace[212219063] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"156.014299ms","start":"2026-05-27T00:41:04.001102Z","end":"2026-05-27T00:41:04.157117Z","steps":["trace[212219063] 'process raft request' (duration: 155.767886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.157264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:03.413571Z","time spent":"743.615016ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4b29b55-562a-40a5-aac9-58d876144933\" "} {"level":"warn","ts":"2026-05-27T00:41:04.165655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.46408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:41:04.165718Z","caller":"traceutil/trace.go:171","msg":"trace[2129115245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1854; }","duration":"591.563482ms","start":"2026-05-27T00:41:03.574139Z","end":"2026-05-27T00:41:04.165703Z","steps":["trace[2129115245] 'agreement among raft nodes before linearized reading' (duration: 591.434489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.165753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:03.57412Z","time spent":"591.626063ms","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T00:41:04.709418Z","caller":"traceutil/trace.go:171","msg":"trace[1695608340] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"450.273424ms","start":"2026-05-27T00:41:04.259119Z","end":"2026-05-27T00:41:04.709392Z","steps":["trace[1695608340] 'process raft request' (duration: 450.057631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.709537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:04.259091Z","time spent":"450.371114ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:41:04.709554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.14163ms","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-05-27T00:41:04.709399Z","caller":"traceutil/trace.go:171","msg":"trace[897797838] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"411.955788ms","start":"2026-05-27T00:41:04.297416Z","end":"2026-05-27T00:41:04.709372Z","steps":["trace[897797838] 'read index received' (duration: 411.745346ms)","trace[897797838] 'applied index is now lower than readState.Index' (duration: 209.432µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:04.709591Z","caller":"traceutil/trace.go:171","msg":"trace[807874231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1855; }","duration":"412.232972ms","start":"2026-05-27T00:41:04.297349Z","end":"2026-05-27T00:41:04.709582Z","steps":["trace[807874231] 'agreement among raft nodes before linearized reading' (duration: 412.09998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.70989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:04.297317Z","time spent":"412.503736ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T00:41:04.856968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.950743ms","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-05-27T00:41:04.857061Z","caller":"traceutil/trace.go:171","msg":"trace[1787903545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1855; }","duration":"504.080395ms","start":"2026-05-27T00:41:04.352957Z","end":"2026-05-27T00:41:04.857037Z","steps":["trace[1787903545] 'agreement among raft nodes before linearized reading' (duration: 356.998914ms)","trace[1787903545] 'range keys from in-memory index tree' (duration: 146.875758ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:04.857105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:04.352944Z","time spent":"504.151975ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T00:41:04.857094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.201642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:41:04.857193Z","caller":"traceutil/trace.go:171","msg":"trace[551524144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1855; }","duration":"232.360664ms","start":"2026-05-27T00:41:04.624802Z","end":"2026-05-27T00:41:04.857163Z","steps":["trace[551524144] 'agreement among raft nodes before linearized reading' (duration: 85.117992ms)","trace[551524144] 'count revisions from in-memory index tree' (duration: 147.097641ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:04.857249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.133894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T00:41:04.8573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.943387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:41:04.857329Z","caller":"traceutil/trace.go:171","msg":"trace[64623954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"281.258756ms","start":"2026-05-27T00:41:04.57605Z","end":"2026-05-27T00:41:04.857308Z","steps":["trace[64623954] 'agreement among raft nodes before linearized reading' (duration: 133.897002ms)","trace[64623954] 'range keys from in-memory index tree' (duration: 147.258883ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:04.857383Z","caller":"traceutil/trace.go:171","msg":"trace[971448156] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1855; }","duration":"260.112109ms","start":"2026-05-27T00:41:04.59725Z","end":"2026-05-27T00:41:04.857362Z","steps":["trace[971448156] 'agreement among raft nodes before linearized reading' (duration: 112.682604ms)","trace[971448156] 'count revisions from in-memory index tree' (duration: 147.284183ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:04.857496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.030485ms","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-05-27T00:41:04.857556Z","caller":"traceutil/trace.go:171","msg":"trace[152735155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1855; }","duration":"538.094307ms","start":"2026-05-27T00:41:04.319434Z","end":"2026-05-27T00:41:04.857529Z","steps":["trace[152735155] 'agreement among raft nodes before linearized reading' (duration: 390.391719ms)","trace[152735155] 'range keys from in-memory index tree' (duration: 147.575316ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:04.857595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:04.319423Z","time spent":"538.162387ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T00:41:04.857754Z","caller":"traceutil/trace.go:171","msg":"trace[2117937085] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"110.223196ms","start":"2026-05-27T00:41:04.747518Z","end":"2026-05-27T00:41:04.857741Z","steps":["trace[2117937085] 'read index received' (duration: 99.85776ms)","trace[2117937085] 'applied index is now lower than readState.Index' (duration: 10.364436ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:04.857829Z","caller":"traceutil/trace.go:171","msg":"trace[1122092622] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"143.438748ms","start":"2026-05-27T00:41:04.714374Z","end":"2026-05-27T00:41:04.857813Z","steps":["trace[1122092622] 'process raft request' (duration: 133.107772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.857938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.422298ms","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-05-27T00:41:04.857973Z","caller":"traceutil/trace.go:171","msg":"trace[361400979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1856; }","duration":"110.49848ms","start":"2026-05-27T00:41:04.747465Z","end":"2026-05-27T00:41:04.857964Z","steps":["trace[361400979] 'agreement among raft nodes before linearized reading' (duration: 110.367028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:04.857981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.964062ms","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-05-27T00:41:04.858189Z","caller":"traceutil/trace.go:171","msg":"trace[426393942] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1856; }","duration":"105.193344ms","start":"2026-05-27T00:41:04.752981Z","end":"2026-05-27T00:41:04.858175Z","steps":["trace[426393942] 'agreement among raft nodes before linearized reading' (duration: 104.87688ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:20.7791Z","caller":"traceutil/trace.go:171","msg":"trace[651284292] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2066; }","duration":"202.613748ms","start":"2026-05-27T00:41:20.57646Z","end":"2026-05-27T00:41:20.779074Z","steps":["trace[651284292] 'read index received' (duration: 202.384925ms)","trace[651284292] 'applied index is now lower than readState.Index' (duration: 227.773µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:20.779226Z","caller":"traceutil/trace.go:171","msg":"trace[141938821] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"270.186697ms","start":"2026-05-27T00:41:20.508996Z","end":"2026-05-27T00:41:20.779183Z","steps":["trace[141938821] 'process raft request' (duration: 269.835643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:20.779312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.83417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:41:20.779373Z","caller":"traceutil/trace.go:171","msg":"trace[1590695107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1990; }","duration":"202.939291ms","start":"2026-05-27T00:41:20.576419Z","end":"2026-05-27T00:41:20.779359Z","steps":["trace[1590695107] 'agreement among raft nodes before linearized reading' (duration: 202.784259ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:21.227682Z","caller":"traceutil/trace.go:171","msg":"trace[2098510949] linearizableReadLoop","detail":"{readStateIndex:2069; appliedIndex:2069; }","duration":"287.066503ms","start":"2026-05-27T00:41:20.940589Z","end":"2026-05-27T00:41:21.227656Z","steps":["trace[2098510949] 'read index received' (duration: 287.056773ms)","trace[2098510949] 'applied index is now lower than readState.Index' (duration: 7.65µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:21.228009Z","caller":"traceutil/trace.go:171","msg":"trace[2100398461] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"289.115138ms","start":"2026-05-27T00:41:20.938872Z","end":"2026-05-27T00:41:21.227987Z","steps":["trace[2100398461] 'process raft request' (duration: 288.624333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:21.227944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.333107ms","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-05-27T00:41:21.228621Z","caller":"traceutil/trace.go:171","msg":"trace[1765638322] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1992; }","duration":"288.048625ms","start":"2026-05-27T00:41:20.940552Z","end":"2026-05-27T00:41:21.2286Z","steps":["trace[1765638322] 'agreement among raft nodes before linearized reading' (duration: 287.226036ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:21.229171Z","caller":"traceutil/trace.go:171","msg":"trace[2040739087] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"138.987813ms","start":"2026-05-27T00:41:21.090159Z","end":"2026-05-27T00:41:21.229147Z","steps":["trace[2040739087] 'process raft request' (duration: 138.855442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:21.229245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.064903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T00:41:21.229292Z","caller":"traceutil/trace.go:171","msg":"trace[123720667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1993; }","duration":"188.167504ms","start":"2026-05-27T00:41:21.041112Z","end":"2026-05-27T00:41:21.22928Z","steps":["trace[123720667] 'agreement among raft nodes before linearized reading' (duration: 187.973222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:21.229454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.455614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T00:41:21.229488Z","caller":"traceutil/trace.go:171","msg":"trace[988067094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1993; }","duration":"180.506944ms","start":"2026-05-27T00:41:21.048973Z","end":"2026-05-27T00:41:21.22948Z","steps":["trace[988067094] 'agreement among raft nodes before linearized reading' (duration: 180.414973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:21.229597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.428865ms","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-05-27T00:41:21.229632Z","caller":"traceutil/trace.go:171","msg":"trace[1760716144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1993; }","duration":"181.488115ms","start":"2026-05-27T00:41:21.048134Z","end":"2026-05-27T00:41:21.229623Z","steps":["trace[1760716144] 'agreement among raft nodes before linearized reading' (duration: 181.414304ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:44.662068Z","caller":"traceutil/trace.go:171","msg":"trace[1068407266] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"358.658796ms","start":"2026-05-27T00:41:44.303383Z","end":"2026-05-27T00:41:44.662042Z","steps":["trace[1068407266] 'process raft request' (duration: 259.082517ms)","trace[1068407266] 'compare' (duration: 99.433107ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:44.662193Z","caller":"traceutil/trace.go:171","msg":"trace[978938155] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2204; }","duration":"144.025001ms","start":"2026-05-27T00:41:44.51814Z","end":"2026-05-27T00:41:44.662165Z","steps":["trace[978938155] 'read index received' (duration: 44.370302ms)","trace[978938155] 'applied index is now lower than readState.Index' (duration: 99.652569ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:44.66222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:44.303366Z","time spent":"358.774707ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:41:44.662258Z","caller":"traceutil/trace.go:171","msg":"trace[1640911813] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"284.34127ms","start":"2026-05-27T00:41:44.377899Z","end":"2026-05-27T00:41:44.66224Z","steps":["trace[1640911813] 'process raft request' (duration: 284.109258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:44.662483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.348125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T00:41:44.663298Z","caller":"traceutil/trace.go:171","msg":"trace[1802120729] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2124; }","duration":"145.110824ms","start":"2026-05-27T00:41:44.518082Z","end":"2026-05-27T00:41:44.663193Z","steps":["trace[1802120729] 'agreement among raft nodes before linearized reading' (duration: 144.180303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:44.6636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.924624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-27T00:41:44.663677Z","caller":"traceutil/trace.go:171","msg":"trace[827321407] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2124; }","duration":"101.052915ms","start":"2026-05-27T00:41:44.562604Z","end":"2026-05-27T00:41:44.663657Z","steps":["trace[827321407] 'agreement among raft nodes before linearized reading' (duration: 100.782982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.707312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.509631ms","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-05-27T00:41:45.707326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.251725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:41:45.707429Z","caller":"traceutil/trace.go:171","msg":"trace[1830749743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2125; }","duration":"351.660033ms","start":"2026-05-27T00:41:45.355722Z","end":"2026-05-27T00:41:45.707382Z","steps":["trace[1830749743] 'range keys from in-memory index tree' (duration: 351.285069ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:45.707429Z","caller":"traceutil/trace.go:171","msg":"trace[939008100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2125; }","duration":"132.411876ms","start":"2026-05-27T00:41:45.574991Z","end":"2026-05-27T00:41:45.707403Z","steps":["trace[939008100] 'range keys from in-memory index tree' (duration: 132.175994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.707442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.881125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-27T00:41:45.707475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.355702Z","time spent":"351.763344ms","remote":"127.0.0.1:56304","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":"info","ts":"2026-05-27T00:41:45.707513Z","caller":"traceutil/trace.go:171","msg":"trace[807460073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2125; }","duration":"350.996075ms","start":"2026-05-27T00:41:45.3565Z","end":"2026-05-27T00:41:45.707496Z","steps":["trace[807460073] 'range keys from in-memory index tree' (duration: 350.743483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.707552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.356491Z","time spent":"351.052616ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T00:41:45.708024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.466116ms","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-05-27T00:41:45.708097Z","caller":"traceutil/trace.go:171","msg":"trace[1636822944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2125; }","duration":"355.572577ms","start":"2026-05-27T00:41:45.352506Z","end":"2026-05-27T00:41:45.708078Z","steps":["trace[1636822944] 'range keys from in-memory index tree' (duration: 355.354655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.708134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.352493Z","time spent":"355.633108ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T00:41:45.708202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.118966ms","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-05-27T00:41:45.708301Z","caller":"traceutil/trace.go:171","msg":"trace[549553614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2125; }","duration":"364.270467ms","start":"2026-05-27T00:41:45.344008Z","end":"2026-05-27T00:41:45.708279Z","steps":["trace[549553614] 'range keys from in-memory index tree' (duration: 363.964414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.708349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.343984Z","time spent":"364.353919ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T00:41:45.708132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.31374ms","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-05-27T00:41:45.708626Z","caller":"traceutil/trace.go:171","msg":"trace[1302312710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2125; }","duration":"372.715274ms","start":"2026-05-27T00:41:45.335758Z","end":"2026-05-27T00:41:45.708474Z","steps":["trace[1302312710] 'range keys from in-memory index tree' (duration: 372.113058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:45.708708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.335726Z","time spent":"372.962548ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T00:41:46.128659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.994192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:41:46.129231Z","caller":"traceutil/trace.go:171","msg":"trace[815270265] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2208; }","duration":"216.574704ms","start":"2026-05-27T00:41:45.912636Z","end":"2026-05-27T00:41:46.12921Z","steps":["trace[815270265] 'read index received' (duration: 29.97µs)","trace[815270265] 'applied index is now lower than readState.Index' (duration: 216.543814ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:46.129224Z","caller":"traceutil/trace.go:171","msg":"trace[1068410586] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"415.388275ms","start":"2026-05-27T00:41:45.713795Z","end":"2026-05-27T00:41:46.129183Z","steps":["trace[1068410586] 'process raft request' (duration: 136.771056ms)","trace[1068410586] 'compare' (duration: 277.764199ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:41:46.129409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.713768Z","time spent":"415.541507ms","remote":"127.0.0.1:56304","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-05-27T00:41:46.129418Z","caller":"traceutil/trace.go:171","msg":"trace[519307136] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"414.487215ms","start":"2026-05-27T00:41:45.714903Z","end":"2026-05-27T00:41:46.12939Z","steps":["trace[519307136] 'process raft request' (duration: 413.926259ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:46.12944Z","caller":"traceutil/trace.go:171","msg":"trace[1968162312] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"415.258113ms","start":"2026-05-27T00:41:45.714153Z","end":"2026-05-27T00:41:46.129412Z","steps":["trace[1968162312] 'process raft request' (duration: 414.613446ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:46.129493Z","caller":"traceutil/trace.go:171","msg":"trace[1004540467] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"414.403384ms","start":"2026-05-27T00:41:45.715014Z","end":"2026-05-27T00:41:46.129417Z","steps":["trace[1004540467] 'process raft request' (duration: 414.109481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:46.129605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.714139Z","time spent":"415.382626ms","remote":"127.0.0.1:56304","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-05-27T00:41:46.129668Z","caller":"traceutil/trace.go:171","msg":"trace[506950853] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"414.532816ms","start":"2026-05-27T00:41:45.715092Z","end":"2026-05-27T00:41:46.129625Z","steps":["trace[506950853] 'process raft request' (duration: 414.072931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:46.129782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.715075Z","time spent":"414.669947ms","remote":"127.0.0.1:56304","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-05-27T00:41:46.129786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.715008Z","time spent":"414.618207ms","remote":"127.0.0.1:56304","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-05-27T00:41:46.129566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.714894Z","time spent":"414.591266ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:41:46.129841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.15018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-05-27T00:41:46.130099Z","caller":"traceutil/trace.go:171","msg":"trace[1203128977] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2131; }","duration":"217.498985ms","start":"2026-05-27T00:41:45.912584Z","end":"2026-05-27T00:41:46.130083Z","steps":["trace[1203128977] 'agreement among raft nodes before linearized reading' (duration: 216.696045ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:52.380522Z","caller":"traceutil/trace.go:171","msg":"trace[1588396626] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"180.925843ms","start":"2026-05-27T00:41:52.199557Z","end":"2026-05-27T00:41:52.380483Z","steps":["trace[1588396626] 'process raft request' (duration: 107.751875ms)","trace[1588396626] 'compare' (duration: 72.772764ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:52.380554Z","caller":"traceutil/trace.go:171","msg":"trace[1178655977] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"178.368154ms","start":"2026-05-27T00:41:52.202164Z","end":"2026-05-27T00:41:52.380533Z","steps":["trace[1178655977] 'process raft request' (duration: 178.199612ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:52.380623Z","caller":"traceutil/trace.go:171","msg":"trace[617500970] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"178.344644ms","start":"2026-05-27T00:41:52.202261Z","end":"2026-05-27T00:41:52.380606Z","steps":["trace[617500970] 'process raft request' (duration: 178.207722ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:42.603349Z","caller":"traceutil/trace.go:171","msg":"trace[428405184] transaction","detail":"{read_only:false; response_revision:2535; number_of_response:1; }","duration":"158.994316ms","start":"2026-05-27T00:42:42.444322Z","end":"2026-05-27T00:42:42.603316Z","steps":["trace[428405184] 'process raft request' (duration: 158.794611ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:42.604503Z","caller":"traceutil/trace.go:171","msg":"trace[805802574] linearizableReadLoop","detail":"{readStateIndex:2632; appliedIndex:2630; }","duration":"141.507918ms","start":"2026-05-27T00:42:42.462976Z","end":"2026-05-27T00:42:42.604484Z","steps":["trace[805802574] 'read index received' (duration: 140.171218ms)","trace[805802574] 'applied index is now lower than readState.Index' (duration: 1.3358ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:42:42.604534Z","caller":"traceutil/trace.go:171","msg":"trace[570995813] transaction","detail":"{read_only:false; response_revision:2536; number_of_response:1; }","duration":"152.070457ms","start":"2026-05-27T00:42:42.452435Z","end":"2026-05-27T00:42:42.604505Z","steps":["trace[570995813] 'process raft request' (duration: 151.854871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:42:42.604676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.680063ms","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-05-27T00:42:42.604702Z","caller":"traceutil/trace.go:171","msg":"trace[1492148969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2537; }","duration":"141.745326ms","start":"2026-05-27T00:42:42.462948Z","end":"2026-05-27T00:42:42.604694Z","steps":["trace[1492148969] 'agreement among raft nodes before linearized reading' (duration: 141.631792ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:08.953121Z","caller":"traceutil/trace.go:171","msg":"trace[625624085] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"201.397845ms","start":"2026-05-27T00:43:08.751691Z","end":"2026-05-27T00:43:08.953089Z","steps":["trace[625624085] 'process raft request' (duration: 142.461196ms)","trace[625624085] 'compare' (duration: 58.818836ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:08.953372Z","caller":"traceutil/trace.go:171","msg":"trace[604480410] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"201.077997ms","start":"2026-05-27T00:43:08.752265Z","end":"2026-05-27T00:43:08.953343Z","steps":["trace[604480410] 'process raft request' (duration: 200.7987ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:08.953406Z","caller":"traceutil/trace.go:171","msg":"trace[544664376] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"200.345447ms","start":"2026-05-27T00:43:08.753032Z","end":"2026-05-27T00:43:08.953378Z","steps":["trace[544664376] 'process raft request' (duration: 200.209073ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:08.953418Z","caller":"traceutil/trace.go:171","msg":"trace[1815983953] linearizableReadLoop","detail":"{readStateIndex:2786; appliedIndex:2783; }","duration":"153.549037ms","start":"2026-05-27T00:43:08.799844Z","end":"2026-05-27T00:43:08.953393Z","steps":["trace[1815983953] 'read index received' (duration: 94.252948ms)","trace[1815983953] 'applied index is now lower than readState.Index' (duration: 59.295129ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:43:08.953775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.431404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-27T00:43:08.953882Z","caller":"traceutil/trace.go:171","msg":"trace[1718052990] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2685; }","duration":"153.564568ms","start":"2026-05-27T00:43:08.800286Z","end":"2026-05-27T00:43:08.953851Z","steps":["trace[1718052990] 'agreement among raft nodes before linearized reading' (duration: 153.313271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:08.953804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.913987ms","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-05-27T00:43:08.954178Z","caller":"traceutil/trace.go:171","msg":"trace[381445226] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2685; }","duration":"154.352789ms","start":"2026-05-27T00:43:08.799811Z","end":"2026-05-27T00:43:08.954164Z","steps":["trace[381445226] 'agreement among raft nodes before linearized reading' (duration: 153.714392ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.042148Z","caller":"traceutil/trace.go:171","msg":"trace[1688557825] linearizableReadLoop","detail":"{readStateIndex:2816; appliedIndex:2815; }","duration":"246.170916ms","start":"2026-05-27T00:43:14.795953Z","end":"2026-05-27T00:43:15.042124Z","steps":["trace[1688557825] 'read index received' (duration: 246.018652ms)","trace[1688557825] 'applied index is now lower than readState.Index' (duration: 151.004µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:15.042179Z","caller":"traceutil/trace.go:171","msg":"trace[1142134089] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"300.021563ms","start":"2026-05-27T00:43:14.742123Z","end":"2026-05-27T00:43:15.042144Z","steps":["trace[1142134089] 'process raft request' (duration: 299.850829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.042316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.742092Z","time spent":"300.151817ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:43:15.042385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.426602ms","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-05-27T00:43:15.042418Z","caller":"traceutil/trace.go:171","msg":"trace[1489212707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2713; }","duration":"246.514294ms","start":"2026-05-27T00:43:14.795894Z","end":"2026-05-27T00:43:15.042408Z","steps":["trace[1489212707] 'agreement among raft nodes before linearized reading' (duration: 246.34786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.760578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.506085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:43:15.76108Z","caller":"traceutil/trace.go:171","msg":"trace[1476553246] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"501.4579ms","start":"2026-05-27T00:43:15.259604Z","end":"2026-05-27T00:43:15.761062Z","steps":["trace[1476553246] 'process raft request' (duration: 501.392489ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.761072Z","caller":"traceutil/trace.go:171","msg":"trace[380988974] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"763.004933ms","start":"2026-05-27T00:43:14.998039Z","end":"2026-05-27T00:43:15.761044Z","steps":["trace[380988974] 'process raft request' (duration: 762.641493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.761166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:15.259586Z","time spent":"501.541543ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:43:15.76127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.998023Z","time spent":"763.115355ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:43:15.76129Z","caller":"traceutil/trace.go:171","msg":"trace[728574548] linearizableReadLoop","detail":"{readStateIndex:2818; appliedIndex:2816; }","duration":"719.057771ms","start":"2026-05-27T00:43:15.042213Z","end":"2026-05-27T00:43:15.761271Z","steps":["trace[728574548] 'read index received' (duration: 368.779085ms)","trace[728574548] 'applied index is now lower than readState.Index' (duration: 350.276816ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:15.761444Z","caller":"traceutil/trace.go:171","msg":"trace[1735349873] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"715.071645ms","start":"2026-05-27T00:43:15.046344Z","end":"2026-05-27T00:43:15.761415Z","steps":["trace[1735349873] 'process raft request' (duration: 714.423238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.761583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.268022ms","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-05-27T00:43:15.761632Z","caller":"traceutil/trace.go:171","msg":"trace[1371986109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2717; }","duration":"782.351015ms","start":"2026-05-27T00:43:14.979269Z","end":"2026-05-27T00:43:15.76162Z","steps":["trace[1371986109] 'agreement among raft nodes before linearized reading' (duration: 782.108799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.761586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:15.046319Z","time spent":"715.213589ms","remote":"127.0.0.1:56304","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-05-27T00:43:15.761653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.624909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-27T00:43:15.76178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.615595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-27T00:43:15.76166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.979264Z","time spent":"782.388886ms","remote":"127.0.0.1:56304","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-05-27T00:43:15.761817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.931825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T00:43:15.761765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.941615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b34564643b7efd\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-27T00:43:15.761864Z","caller":"traceutil/trace.go:171","msg":"trace[1980099001] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2717; }","duration":"163.010487ms","start":"2026-05-27T00:43:15.598839Z","end":"2026-05-27T00:43:15.761849Z","steps":["trace[1980099001] 'agreement among raft nodes before linearized reading' (duration: 162.953845ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.761882Z","caller":"traceutil/trace.go:171","msg":"trace[479923293] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b34564643b7efd; range_end:; response_count:1; response_revision:2717; }","duration":"538.091109ms","start":"2026-05-27T00:43:15.223781Z","end":"2026-05-27T00:43:15.761872Z","steps":["trace[479923293] 'agreement among raft nodes before linearized reading' (duration: 537.905724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.761916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:15.22376Z","time spent":"538.14429ms","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b34564643b7efd\" "} {"level":"info","ts":"2026-05-27T00:43:15.761921Z","caller":"traceutil/trace.go:171","msg":"trace[1716109910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2717; }","duration":"783.872846ms","start":"2026-05-27T00:43:14.977935Z","end":"2026-05-27T00:43:15.761808Z","steps":["trace[1716109910] 'agreement among raft nodes before linearized reading' (duration: 783.476906ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.761915Z","caller":"traceutil/trace.go:171","msg":"trace[607117339] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"783.714381ms","start":"2026-05-27T00:43:14.977566Z","end":"2026-05-27T00:43:15.76128Z","steps":["trace[607117339] 'process raft request' (duration: 433.408985ms)","trace[607117339] 'compare' (duration: 349.342831ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:43:15.762026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.977926Z","time spent":"784.084981ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T00:43:15.762165Z","caller":"traceutil/trace.go:171","msg":"trace[395820448] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2717; }","duration":"761.682947ms","start":"2026-05-27T00:43:15.000132Z","end":"2026-05-27T00:43:15.761815Z","steps":["trace[395820448] 'agreement among raft nodes before linearized reading' (duration: 761.583014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.76201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.67911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T00:43:15.762205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:15.000121Z","time spent":"762.075147ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T00:43:15.762224Z","caller":"traceutil/trace.go:171","msg":"trace[575671516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2717; }","duration":"187.910215ms","start":"2026-05-27T00:43:15.574293Z","end":"2026-05-27T00:43:15.762203Z","steps":["trace[575671516] 'agreement among raft nodes before linearized reading' (duration: 187.689879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.762221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.977544Z","time spent":"784.580964ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:43:15.76229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.829737ms","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-05-27T00:43:15.76269Z","caller":"traceutil/trace.go:171","msg":"trace[1650687765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2717; }","duration":"783.358721ms","start":"2026-05-27T00:43:14.979294Z","end":"2026-05-27T00:43:15.762653Z","steps":["trace[1650687765] 'agreement among raft nodes before linearized reading' (duration: 782.004206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.765261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:14.979291Z","time spent":"785.816286ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-27T00:43:15.903541Z","caller":"traceutil/trace.go:171","msg":"trace[1291175912] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"136.96094ms","start":"2026-05-27T00:43:15.766554Z","end":"2026-05-27T00:43:15.903515Z","steps":["trace[1291175912] 'process raft request' (duration: 132.44655ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.903706Z","caller":"traceutil/trace.go:171","msg":"trace[1376640279] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"137.112183ms","start":"2026-05-27T00:43:15.766578Z","end":"2026-05-27T00:43:15.90369Z","steps":["trace[1376640279] 'process raft request' (duration: 136.893967ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.90416Z","caller":"traceutil/trace.go:171","msg":"trace[528548455] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"137.476803ms","start":"2026-05-27T00:43:15.766655Z","end":"2026-05-27T00:43:15.904131Z","steps":["trace[528548455] 'process raft request' (duration: 136.970889ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:15.904302Z","caller":"traceutil/trace.go:171","msg":"trace[1967741701] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"135.270665ms","start":"2026-05-27T00:43:15.768972Z","end":"2026-05-27T00:43:15.904243Z","steps":["trace[1967741701] 'process raft request' (duration: 135.07863ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:20.945218Z","caller":"traceutil/trace.go:171","msg":"trace[1515716008] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"273.40776ms","start":"2026-05-27T00:43:20.671776Z","end":"2026-05-27T00:43:20.945184Z","steps":["trace[1515716008] 'process raft request' (duration: 273.179465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:02.976721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.703249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7508"} {"level":"info","ts":"2026-05-27T00:45:02.976811Z","caller":"traceutil/trace.go:171","msg":"trace[1337256968] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:3285; }","duration":"135.834501ms","start":"2026-05-27T00:45:02.840957Z","end":"2026-05-27T00:45:02.976791Z","steps":["trace[1337256968] 'range keys from in-memory index tree' (duration: 135.23913ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:10.946487Z","caller":"traceutil/trace.go:171","msg":"trace[1214513822] transaction","detail":"{read_only:false; response_revision:3405; number_of_response:1; }","duration":"179.977031ms","start":"2026-05-27T00:45:10.766481Z","end":"2026-05-27T00:45:10.946458Z","steps":["trace[1214513822] 'process raft request' (duration: 89.293167ms)","trace[1214513822] 'compare' (duration: 90.546941ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:11.720299Z","caller":"traceutil/trace.go:171","msg":"trace[865466850] transaction","detail":"{read_only:false; response_revision:3407; number_of_response:1; }","duration":"117.102618ms","start":"2026-05-27T00:45:11.603176Z","end":"2026-05-27T00:45:11.720278Z","steps":["trace[865466850] 'process raft request' (duration: 116.964374ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:30.875346Z","caller":"traceutil/trace.go:171","msg":"trace[978962225] linearizableReadLoop","detail":"{readStateIndex:3652; appliedIndex:3651; }","duration":"103.335855ms","start":"2026-05-27T00:45:30.771984Z","end":"2026-05-27T00:45:30.87532Z","steps":["trace[978962225] 'read index received' (duration: 103.082591ms)","trace[978962225] 'applied index is now lower than readState.Index' (duration: 252.004µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:30.875398Z","caller":"traceutil/trace.go:171","msg":"trace[121306584] transaction","detail":"{read_only:false; response_revision:3517; number_of_response:1; }","duration":"124.51779ms","start":"2026-05-27T00:45:30.750849Z","end":"2026-05-27T00:45:30.875367Z","steps":["trace[121306584] 'process raft request' (duration: 124.307546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:30.875628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.619431ms","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-05-27T00:45:30.875686Z","caller":"traceutil/trace.go:171","msg":"trace[1949250299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3517; }","duration":"103.729382ms","start":"2026-05-27T00:45:30.771942Z","end":"2026-05-27T00:45:30.875671Z","steps":["trace[1949250299] 'agreement among raft nodes before linearized reading' (duration: 103.537959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:41.267786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.410573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:45:41.267998Z","caller":"traceutil/trace.go:171","msg":"trace[1728956171] linearizableReadLoop","detail":"{readStateIndex:3707; appliedIndex:3704; }","duration":"231.741961ms","start":"2026-05-27T00:45:41.036239Z","end":"2026-05-27T00:45:41.267981Z","steps":["trace[1728956171] 'read index received' (duration: 26.147725ms)","trace[1728956171] 'applied index is now lower than readState.Index' (duration: 205.593176ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:41.268156Z","caller":"traceutil/trace.go:171","msg":"trace[605078197] transaction","detail":"{read_only:false; response_revision:3570; number_of_response:1; }","duration":"274.722966ms","start":"2026-05-27T00:45:40.993403Z","end":"2026-05-27T00:45:41.268126Z","steps":["trace[605078197] 'process raft request' (duration: 274.475042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:41.268304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.418082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-27T00:45:41.268342Z","caller":"traceutil/trace.go:171","msg":"trace[97811448] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3570; }","duration":"219.494224ms","start":"2026-05-27T00:45:41.048837Z","end":"2026-05-27T00:45:41.268331Z","steps":["trace[97811448] 'agreement among raft nodes before linearized reading' (duration: 219.413902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:41.268492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.358755ms","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-05-27T00:45:41.268524Z","caller":"traceutil/trace.go:171","msg":"trace[1568361935] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:3570; }","duration":"167.436647ms","start":"2026-05-27T00:45:41.101079Z","end":"2026-05-27T00:45:41.268516Z","steps":["trace[1568361935] 'agreement among raft nodes before linearized reading' (duration: 167.379886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:41.268756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.871516ms","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-05-27T00:45:41.268791Z","caller":"traceutil/trace.go:171","msg":"trace[648621262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3570; }","duration":"180.952527ms","start":"2026-05-27T00:45:41.087831Z","end":"2026-05-27T00:45:41.268783Z","steps":["trace[648621262] 'agreement among raft nodes before linearized reading' (duration: 180.858676ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:41.269021Z","caller":"traceutil/trace.go:171","msg":"trace[132301626] transaction","detail":"{read_only:false; response_revision:3569; number_of_response:1; }","duration":"275.633183ms","start":"2026-05-27T00:45:40.993375Z","end":"2026-05-27T00:45:41.269008Z","steps":["trace[132301626] 'process raft request' (duration: 172.908056ms)","trace[132301626] 'compare' (duration: 101.1922ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:41.268222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.999727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-27T00:45:41.270405Z","caller":"traceutil/trace.go:171","msg":"trace[1910057322] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3570; }","duration":"233.077785ms","start":"2026-05-27T00:45:41.036165Z","end":"2026-05-27T00:45:41.269243Z","steps":["trace[1910057322] 'agreement among raft nodes before linearized reading' (duration: 231.911714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:52.550835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.758292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:45:52.550958Z","caller":"traceutil/trace.go:171","msg":"trace[306956226] linearizableReadLoop","detail":"{readStateIndex:3770; appliedIndex:3769; }","duration":"134.67792ms","start":"2026-05-27T00:45:52.416262Z","end":"2026-05-27T00:45:52.55094Z","steps":["trace[306956226] 'read index received' (duration: 11.703394ms)","trace[306956226] 'applied index is now lower than readState.Index' (duration: 122.973236ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:52.551005Z","caller":"traceutil/trace.go:171","msg":"trace[554521693] transaction","detail":"{read_only:false; response_revision:3630; number_of_response:1; }","duration":"139.842381ms","start":"2026-05-27T00:45:52.411125Z","end":"2026-05-27T00:45:52.550967Z","steps":["trace[554521693] 'process raft request' (duration: 16.879035ms)","trace[554521693] 'compare' (duration: 122.59726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:52.551086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.822123ms","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-05-27T00:45:52.551118Z","caller":"traceutil/trace.go:171","msg":"trace[1161637820] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:3630; }","duration":"134.896474ms","start":"2026-05-27T00:45:52.416212Z","end":"2026-05-27T00:45:52.551109Z","steps":["trace[1161637820] 'agreement among raft nodes before linearized reading' (duration: 134.776272ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:17.782348Z","caller":"traceutil/trace.go:171","msg":"trace[145436652] transaction","detail":"{read_only:false; response_revision:3833; number_of_response:1; }","duration":"124.790026ms","start":"2026-05-27T00:46:17.65753Z","end":"2026-05-27T00:46:17.78232Z","steps":["trace[145436652] 'process raft request' (duration: 109.407517ms)","trace[145436652] 'compare' (duration: 15.051464ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:18.183407Z","caller":"traceutil/trace.go:171","msg":"trace[60526801] transaction","detail":"{read_only:false; response_revision:3836; number_of_response:1; }","duration":"146.937044ms","start":"2026-05-27T00:46:18.036441Z","end":"2026-05-27T00:46:18.183378Z","steps":["trace[60526801] 'process raft request' (duration: 110.453813ms)","trace[60526801] 'compare' (duration: 36.358819ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:24.397076Z","caller":"traceutil/trace.go:171","msg":"trace[1193109937] transaction","detail":"{read_only:false; response_revision:3869; number_of_response:1; }","duration":"141.351411ms","start":"2026-05-27T00:46:24.255671Z","end":"2026-05-27T00:46:24.397023Z","steps":["trace[1193109937] 'process raft request' (duration: 118.664964ms)","trace[1193109937] 'compare' (duration: 21.393225ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:33.927833Z","caller":"traceutil/trace.go:171","msg":"trace[486116526] linearizableReadLoop","detail":"{readStateIndex:4076; appliedIndex:4075; }","duration":"179.322587ms","start":"2026-05-27T00:46:33.748483Z","end":"2026-05-27T00:46:33.927806Z","steps":["trace[486116526] 'read index received' (duration: 179.011602ms)","trace[486116526] 'applied index is now lower than readState.Index' (duration: 309.675µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:33.92793Z","caller":"traceutil/trace.go:171","msg":"trace[135550486] transaction","detail":"{read_only:false; response_revision:3923; number_of_response:1; }","duration":"292.421416ms","start":"2026-05-27T00:46:33.635486Z","end":"2026-05-27T00:46:33.927908Z","steps":["trace[135550486] 'process raft request' (duration: 292.09483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:46:33.927973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.472309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:46:33.928031Z","caller":"traceutil/trace.go:171","msg":"trace[1800103046] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:3923; }","duration":"179.581081ms","start":"2026-05-27T00:46:33.748437Z","end":"2026-05-27T00:46:33.928018Z","steps":["trace[1800103046] 'agreement among raft nodes before linearized reading' (duration: 179.4838ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:34.192884Z","caller":"traceutil/trace.go:171","msg":"trace[363732314] transaction","detail":"{read_only:false; response_revision:3924; number_of_response:1; }","duration":"260.351684ms","start":"2026-05-27T00:46:33.932508Z","end":"2026-05-27T00:46:34.192859Z","steps":["trace[363732314] 'process raft request' (duration: 192.651103ms)","trace[363732314] 'compare' (duration: 67.356386ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:34.193387Z","caller":"traceutil/trace.go:171","msg":"trace[724012092] transaction","detail":"{read_only:false; response_revision:3925; number_of_response:1; }","duration":"259.556342ms","start":"2026-05-27T00:46:33.933808Z","end":"2026-05-27T00:46:34.193364Z","steps":["trace[724012092] 'process raft request' (duration: 258.975812ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:34.19345Z","caller":"traceutil/trace.go:171","msg":"trace[1590617113] transaction","detail":"{read_only:false; response_revision:3926; number_of_response:1; }","duration":"259.537551ms","start":"2026-05-27T00:46:33.933875Z","end":"2026-05-27T00:46:34.193412Z","steps":["trace[1590617113] 'process raft request' (duration: 259.133225ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:34.827255Z","caller":"traceutil/trace.go:171","msg":"trace[13520650] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3927; }","duration":"239.852926ms","start":"2026-05-27T00:46:34.587372Z","end":"2026-05-27T00:46:34.827225Z","steps":["trace[13520650] 'process raft request' (duration: 239.722894ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:34.958326Z","caller":"traceutil/trace.go:171","msg":"trace[1083502427] linearizableReadLoop","detail":"{readStateIndex:4082; appliedIndex:4081; }","duration":"129.705069ms","start":"2026-05-27T00:46:34.828595Z","end":"2026-05-27T00:46:34.9583Z","steps":["trace[1083502427] 'read index received' (duration: 129.618497ms)","trace[1083502427] 'applied index is now lower than readState.Index' (duration: 85.642µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:34.958464Z","caller":"traceutil/trace.go:171","msg":"trace[1941559563] transaction","detail":"{read_only:false; response_revision:3928; number_of_response:1; }","duration":"141.95666ms","start":"2026-05-27T00:46:34.816468Z","end":"2026-05-27T00:46:34.958425Z","steps":["trace[1941559563] 'process raft request' (duration: 141.694586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:46:34.95861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.996153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagerconfigs.monitoring.coreos.com\" ","response":"range_response_count:1 size:156632"} {"level":"info","ts":"2026-05-27T00:46:34.958653Z","caller":"traceutil/trace.go:171","msg":"trace[187485062] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagerconfigs.monitoring.coreos.com; range_end:; response_count:1; response_revision:3928; }","duration":"130.094684ms","start":"2026-05-27T00:46:34.828548Z","end":"2026-05-27T00:46:34.958642Z","steps":["trace[187485062] 'agreement among raft nodes before linearized reading' (duration: 129.84585ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:50.875839Z","caller":"traceutil/trace.go:171","msg":"trace[381307253] transaction","detail":"{read_only:false; response_revision:4022; number_of_response:1; }","duration":"183.845911ms","start":"2026-05-27T00:46:50.69197Z","end":"2026-05-27T00:46:50.875816Z","steps":["trace[381307253] 'process raft request' (duration: 183.449055ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:52.509451Z","caller":"traceutil/trace.go:171","msg":"trace[1517500985] transaction","detail":"{read_only:false; response_revision:4040; number_of_response:1; }","duration":"107.046949ms","start":"2026-05-27T00:46:52.402368Z","end":"2026-05-27T00:46:52.509415Z","steps":["trace[1517500985] 'process raft request' (duration: 41.208152ms)","trace[1517500985] 'compare' (duration: 65.623244ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:53.675095Z","caller":"traceutil/trace.go:171","msg":"trace[2010510091] linearizableReadLoop","detail":"{readStateIndex:4213; appliedIndex:4212; }","duration":"100.010744ms","start":"2026-05-27T00:46:53.575057Z","end":"2026-05-27T00:46:53.675068Z","steps":["trace[2010510091] 'read index received' (duration: 99.75616ms)","trace[2010510091] 'applied index is now lower than readState.Index' (duration: 253.354µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:53.675183Z","caller":"traceutil/trace.go:171","msg":"trace[490246991] transaction","detail":"{read_only:false; response_revision:4045; number_of_response:1; }","duration":"106.109673ms","start":"2026-05-27T00:46:53.569031Z","end":"2026-05-27T00:46:53.675141Z","steps":["trace[490246991] 'process raft request' (duration: 105.844959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:46:53.675323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.178917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:46:53.675403Z","caller":"traceutil/trace.go:171","msg":"trace[58602401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4045; }","duration":"100.35807ms","start":"2026-05-27T00:46:53.57503Z","end":"2026-05-27T00:46:53.675388Z","steps":["trace[58602401] 'agreement among raft nodes before linearized reading' (duration: 100.162297ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:54.566493Z","caller":"traceutil/trace.go:171","msg":"trace[154487743] transaction","detail":"{read_only:false; response_revision:4051; number_of_response:1; }","duration":"203.217517ms","start":"2026-05-27T00:46:54.363238Z","end":"2026-05-27T00:46:54.566456Z","steps":["trace[154487743] 'process raft request' (duration: 202.729788ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:54.567907Z","caller":"traceutil/trace.go:171","msg":"trace[2060827843] transaction","detail":"{read_only:false; response_revision:4052; number_of_response:1; }","duration":"203.37463ms","start":"2026-05-27T00:46:54.364504Z","end":"2026-05-27T00:46:54.567879Z","steps":["trace[2060827843] 'process raft request' (duration: 203.223528ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:54.568302Z","caller":"traceutil/trace.go:171","msg":"trace[1678944023] linearizableReadLoop","detail":"{readStateIndex:4220; appliedIndex:4218; }","duration":"156.540679ms","start":"2026-05-27T00:46:54.411749Z","end":"2026-05-27T00:46:54.56829Z","steps":["trace[1678944023] 'read index received' (duration: 154.296413ms)","trace[1678944023] 'applied index is now lower than readState.Index' (duration: 2.242996ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:46:54.568512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.744733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-27T00:46:54.56873Z","caller":"traceutil/trace.go:171","msg":"trace[344416483] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4052; }","duration":"156.878084ms","start":"2026-05-27T00:46:54.411711Z","end":"2026-05-27T00:46:54.568589Z","steps":["trace[344416483] 'agreement among raft nodes before linearized reading' (duration: 156.648741ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:58.181108Z","caller":"traceutil/trace.go:171","msg":"trace[318167541] transaction","detail":"{read_only:false; response_revision:4077; number_of_response:1; }","duration":"126.514518ms","start":"2026-05-27T00:46:58.054558Z","end":"2026-05-27T00:46:58.181073Z","steps":["trace[318167541] 'process raft request' (duration: 98.074385ms)","trace[318167541] 'compare' (duration: 28.20393ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:58.339958Z","caller":"traceutil/trace.go:171","msg":"trace[487341006] transaction","detail":"{read_only:false; response_revision:4079; number_of_response:1; }","duration":"150.42327ms","start":"2026-05-27T00:46:58.189501Z","end":"2026-05-27T00:46:58.339924Z","steps":["trace[487341006] 'process raft request' (duration: 135.738645ms)","trace[487341006] 'compare' (duration: 14.567723ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:00.57278Z","caller":"traceutil/trace.go:171","msg":"trace[1336504010] transaction","detail":"{read_only:false; response_revision:4404; number_of_response:1; }","duration":"123.593998ms","start":"2026-05-27T00:47:00.449167Z","end":"2026-05-27T00:47:00.572761Z","steps":["trace[1336504010] 'process raft request' (duration: 95.179345ms)","trace[1336504010] 'compare' (duration: 28.063017ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:03.445861Z","caller":"traceutil/trace.go:171","msg":"trace[1008128894] linearizableReadLoop","detail":"{readStateIndex:4702; appliedIndex:4699; }","duration":"168.407102ms","start":"2026-05-27T00:47:03.277436Z","end":"2026-05-27T00:47:03.445843Z","steps":["trace[1008128894] 'read index received' (duration: 62.551292ms)","trace[1008128894] 'applied index is now lower than readState.Index' (duration: 105.85487ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:03.446103Z","caller":"traceutil/trace.go:171","msg":"trace[262089708] transaction","detail":"{read_only:false; response_revision:4525; number_of_response:1; }","duration":"193.711214ms","start":"2026-05-27T00:47:03.252381Z","end":"2026-05-27T00:47:03.446092Z","steps":["trace[262089708] 'process raft request' (duration: 184.989376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:03.446473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.019352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-05-27T00:47:03.446491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.230817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5215ad18-4e6e-4491-b3d5-381abac84cd6\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-27T00:47:03.44652Z","caller":"traceutil/trace.go:171","msg":"trace[1715559177] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4526; }","duration":"169.113554ms","start":"2026-05-27T00:47:03.277393Z","end":"2026-05-27T00:47:03.446506Z","steps":["trace[1715559177] 'agreement among raft nodes before linearized reading' (duration: 168.976792ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:03.446525Z","caller":"traceutil/trace.go:171","msg":"trace[346880967] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5215ad18-4e6e-4491-b3d5-381abac84cd6; range_end:; response_count:1; response_revision:4526; }","duration":"108.306038ms","start":"2026-05-27T00:47:03.338212Z","end":"2026-05-27T00:47:03.446518Z","steps":["trace[346880967] 'agreement among raft nodes before linearized reading' (duration: 108.220917ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:03.446927Z","caller":"traceutil/trace.go:171","msg":"trace[1807895153] transaction","detail":"{read_only:false; response_revision:4526; number_of_response:1; }","duration":"194.072261ms","start":"2026-05-27T00:47:03.252843Z","end":"2026-05-27T00:47:03.446915Z","steps":["trace[1807895153] 'process raft request' (duration: 192.858251ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:08.526868Z","caller":"traceutil/trace.go:171","msg":"trace[1834066024] linearizableReadLoop","detail":"{readStateIndex:4825; appliedIndex:4824; }","duration":"188.473676ms","start":"2026-05-27T00:47:08.338369Z","end":"2026-05-27T00:47:08.526843Z","steps":["trace[1834066024] 'read index received' (duration: 188.264623ms)","trace[1834066024] 'applied index is now lower than readState.Index' (duration: 207.813µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:08.526907Z","caller":"traceutil/trace.go:171","msg":"trace[1767863931] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"192.661003ms","start":"2026-05-27T00:47:08.334211Z","end":"2026-05-27T00:47:08.526872Z","steps":["trace[1767863931] 'process raft request' (duration: 192.424949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.527132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.74644ms","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-05-27T00:47:08.527209Z","caller":"traceutil/trace.go:171","msg":"trace[634741376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4644; }","duration":"188.871582ms","start":"2026-05-27T00:47:08.338319Z","end":"2026-05-27T00:47:08.527191Z","steps":["trace[634741376] 'agreement among raft nodes before linearized reading' (duration: 188.638448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.527395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.205225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:08.527518Z","caller":"traceutil/trace.go:171","msg":"trace[64639851] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4644; }","duration":"149.313787ms","start":"2026-05-27T00:47:08.378125Z","end":"2026-05-27T00:47:08.527439Z","steps":["trace[64639851] 'agreement among raft nodes before linearized reading' (duration: 148.897021ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:08.926872Z","caller":"traceutil/trace.go:171","msg":"trace[430766079] linearizableReadLoop","detail":"{readStateIndex:4827; appliedIndex:4826; }","duration":"190.081022ms","start":"2026-05-27T00:47:08.736763Z","end":"2026-05-27T00:47:08.926844Z","steps":["trace[430766079] 'read index received' (duration: 189.834448ms)","trace[430766079] 'applied index is now lower than readState.Index' (duration: 245.514µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:08.927009Z","caller":"traceutil/trace.go:171","msg":"trace[1323561808] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"212.015759ms","start":"2026-05-27T00:47:08.714978Z","end":"2026-05-27T00:47:08.926994Z","steps":["trace[1323561808] 'process raft request' (duration: 211.678944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.92718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.185851ms","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-05-27T00:47:08.927228Z","caller":"traceutil/trace.go:171","msg":"trace[795754588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4646; }","duration":"188.284823ms","start":"2026-05-27T00:47:08.738931Z","end":"2026-05-27T00:47:08.927216Z","steps":["trace[795754588] 'agreement among raft nodes before linearized reading' (duration: 188.131831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.927392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.686937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:08.927469Z","caller":"traceutil/trace.go:171","msg":"trace[1188017959] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4646; }","duration":"165.813658ms","start":"2026-05-27T00:47:08.761639Z","end":"2026-05-27T00:47:08.927453Z","steps":["trace[1188017959] 'agreement among raft nodes before linearized reading' (duration: 165.703216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.927582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.829414ms","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-05-27T00:47:08.927619Z","caller":"traceutil/trace.go:171","msg":"trace[430264107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4646; }","duration":"190.907004ms","start":"2026-05-27T00:47:08.736703Z","end":"2026-05-27T00:47:08.92761Z","steps":["trace[430264107] 'agreement among raft nodes before linearized reading' (duration: 190.815483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:08.927786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.201969ms","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-05-27T00:47:08.927952Z","caller":"traceutil/trace.go:171","msg":"trace[1329044786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4646; }","duration":"184.435782ms","start":"2026-05-27T00:47:08.743498Z","end":"2026-05-27T00:47:08.927933Z","steps":["trace[1329044786] 'agreement among raft nodes before linearized reading' (duration: 183.915154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:10.504856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.883951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T00:47:10.504859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.775788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j\" ","response":"range_response_count:1 size:9871"} {"level":"warn","ts":"2026-05-27T00:47:10.504878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.912434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j.18b3459f805398fe\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-05-27T00:47:10.504927Z","caller":"traceutil/trace.go:171","msg":"trace[1693485252] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4660; }","duration":"844.992603ms","start":"2026-05-27T00:47:09.659919Z","end":"2026-05-27T00:47:10.504911Z","steps":["trace[1693485252] 'count revisions from in-memory index tree' (duration: 844.644266ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:10.504946Z","caller":"traceutil/trace.go:171","msg":"trace[2120949696] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j; range_end:; response_count:1; response_revision:4660; }","duration":"395.921189ms","start":"2026-05-27T00:47:10.109005Z","end":"2026-05-27T00:47:10.504926Z","steps":["trace[2120949696] 'range keys from in-memory index tree' (duration: 395.503213ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:10.504965Z","caller":"traceutil/trace.go:171","msg":"trace[1638202113] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j.18b3459f805398fe; range_end:; response_count:1; response_revision:4660; }","duration":"395.026677ms","start":"2026-05-27T00:47:10.109911Z","end":"2026-05-27T00:47:10.504938Z","steps":["trace[1638202113] 'range keys from in-memory index tree' (duration: 394.757932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:10.504993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:10.108983Z","time spent":"396.000871ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9894,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j\" "} {"level":"warn","ts":"2026-05-27T00:47:10.505011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:10.109905Z","time spent":"395.095517ms","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":985,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-65h7j.18b3459f805398fe\" "} {"level":"warn","ts":"2026-05-27T00:47:10.505422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.793138ms","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-05-27T00:47:10.505453Z","caller":"traceutil/trace.go:171","msg":"trace[1985189148] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4660; }","duration":"655.860358ms","start":"2026-05-27T00:47:09.849586Z","end":"2026-05-27T00:47:10.505446Z","steps":["trace[1985189148] 'range keys from in-memory index tree' (duration: 655.660126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:10.505473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:09.849567Z","time spent":"655.9013ms","remote":"127.0.0.1:56304","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-05-27T00:47:10.50496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:09.6599Z","time spent":"845.052594ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-05-27T00:47:10.779561Z","caller":"traceutil/trace.go:171","msg":"trace[1834588877] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"265.636876ms","start":"2026-05-27T00:47:10.513902Z","end":"2026-05-27T00:47:10.779539Z","steps":["trace[1834588877] 'process raft request' (duration: 265.520304ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:10.779576Z","caller":"traceutil/trace.go:171","msg":"trace[1289953040] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"269.277973ms","start":"2026-05-27T00:47:10.510271Z","end":"2026-05-27T00:47:10.779549Z","steps":["trace[1289953040] 'process raft request' (duration: 220.921011ms)","trace[1289953040] 'compare' (duration: 47.969616ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:10.9019Z","caller":"traceutil/trace.go:171","msg":"trace[60313287] linearizableReadLoop","detail":"{readStateIndex:4845; appliedIndex:4842; }","duration":"351.261116ms","start":"2026-05-27T00:47:10.55061Z","end":"2026-05-27T00:47:10.901871Z","steps":["trace[60313287] 'read index received' (duration: 180.597166ms)","trace[60313287] 'applied index is now lower than readState.Index' (duration: 170.66294ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:10.901912Z","caller":"traceutil/trace.go:171","msg":"trace[55777490] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"356.04645ms","start":"2026-05-27T00:47:10.545841Z","end":"2026-05-27T00:47:10.901888Z","steps":["trace[55777490] 'process raft request' (duration: 354.703978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:10.902103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.473359ms","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-05-27T00:47:10.902136Z","caller":"traceutil/trace.go:171","msg":"trace[210120092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4663; }","duration":"351.555481ms","start":"2026-05-27T00:47:10.550574Z","end":"2026-05-27T00:47:10.902129Z","steps":["trace[210120092] 'agreement among raft nodes before linearized reading' (duration: 351.392408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:10.902164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:10.550558Z","time spent":"351.600241ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T00:47:10.902256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:10.545828Z","time spent":"356.265754ms","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:15.080001Z","caller":"traceutil/trace.go:171","msg":"trace[1545573805] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"282.359561ms","start":"2026-05-27T00:47:14.797619Z","end":"2026-05-27T00:47:15.079978Z","steps":["trace[1545573805] 'process raft request' (duration: 282.235649ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:15.08003Z","caller":"traceutil/trace.go:171","msg":"trace[1324081573] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4867; }","duration":"277.363151ms","start":"2026-05-27T00:47:14.802636Z","end":"2026-05-27T00:47:15.079999Z","steps":["trace[1324081573] 'read index received' (duration: 277.348981ms)","trace[1324081573] 'applied index is now lower than readState.Index' (duration: 11.44µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:15.080214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.549405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:15.080293Z","caller":"traceutil/trace.go:171","msg":"trace[2064942208] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4684; }","duration":"277.655567ms","start":"2026-05-27T00:47:14.802618Z","end":"2026-05-27T00:47:15.080274Z","steps":["trace[2064942208] 'agreement among raft nodes before linearized reading' (duration: 277.511954ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:15.099445Z","caller":"traceutil/trace.go:171","msg":"trace[210401787] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"109.533848ms","start":"2026-05-27T00:47:14.989897Z","end":"2026-05-27T00:47:15.099431Z","steps":["trace[210401787] 'process raft request' (duration: 109.389926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:15.099605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.099213ms","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-05-27T00:47:15.09969Z","caller":"traceutil/trace.go:171","msg":"trace[648661680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4685; }","duration":"178.224436ms","start":"2026-05-27T00:47:14.921446Z","end":"2026-05-27T00:47:15.099671Z","steps":["trace[648661680] 'agreement among raft nodes before linearized reading' (duration: 177.991782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.34077Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679535663783976666,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T00:47:17.654573Z","caller":"traceutil/trace.go:171","msg":"trace[1393482794] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"910.831199ms","start":"2026-05-27T00:47:16.743715Z","end":"2026-05-27T00:47:17.654546Z","steps":["trace[1393482794] 'process raft request' (duration: 910.639186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.654888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:16.743702Z","time spent":"911.089223ms","remote":"127.0.0.1:43094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:17.703646Z","caller":"traceutil/trace.go:171","msg":"trace[1244996590] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"386.69728ms","start":"2026-05-27T00:47:17.31692Z","end":"2026-05-27T00:47:17.703617Z","steps":["trace[1244996590] 'process raft request' (duration: 386.609459ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:17.703677Z","caller":"traceutil/trace.go:171","msg":"trace[205333161] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"598.958774ms","start":"2026-05-27T00:47:17.104678Z","end":"2026-05-27T00:47:17.703636Z","steps":["trace[205333161] 'process raft request' (duration: 598.664009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.703831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.316895Z","time spent":"386.837253ms","remote":"127.0.0.1:56304","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-05-27T00:47:17.703849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.104652Z","time spent":"599.105107ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:17.703937Z","caller":"traceutil/trace.go:171","msg":"trace[1645257278] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"145.552298ms","start":"2026-05-27T00:47:17.558358Z","end":"2026-05-27T00:47:17.70391Z","steps":["trace[1645257278] 'process raft request' (duration: 145.213883ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:17.704002Z","caller":"traceutil/trace.go:171","msg":"trace[1405976017] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"134.706838ms","start":"2026-05-27T00:47:17.569276Z","end":"2026-05-27T00:47:17.703983Z","steps":["trace[1405976017] 'process raft request' (duration: 134.555466ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:17.70443Z","caller":"traceutil/trace.go:171","msg":"trace[2031773761] linearizableReadLoop","detail":"{readStateIndex:4944; appliedIndex:4941; }","duration":"864.173017ms","start":"2026-05-27T00:47:16.840206Z","end":"2026-05-27T00:47:17.70438Z","steps":["trace[2031773761] 'read index received' (duration: 814.071483ms)","trace[2031773761] 'applied index is now lower than readState.Index' (duration: 50.099284ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:17.704481Z","caller":"traceutil/trace.go:171","msg":"trace[646450879] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"125.051807ms","start":"2026-05-27T00:47:17.579416Z","end":"2026-05-27T00:47:17.704467Z","steps":["trace[646450879] 'process raft request' (duration: 124.498479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.704714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.722824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa07e016-6897-4ddc-8c09-e1e4a02b4089\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-27T00:47:17.704757Z","caller":"traceutil/trace.go:171","msg":"trace[846074998] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa07e016-6897-4ddc-8c09-e1e4a02b4089; range_end:; response_count:1; response_revision:4763; }","duration":"282.812355ms","start":"2026-05-27T00:47:17.421934Z","end":"2026-05-27T00:47:17.704746Z","steps":["trace[846074998] 'agreement among raft nodes before linearized reading' (duration: 282.665102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.704724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.457011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:17.704967Z","caller":"traceutil/trace.go:171","msg":"trace[1204904423] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4763; }","duration":"864.774866ms","start":"2026-05-27T00:47:16.840166Z","end":"2026-05-27T00:47:17.704941Z","steps":["trace[1204904423] 'agreement among raft nodes before linearized reading' (duration: 864.354209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.705007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.99122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:47:17.70504Z","caller":"traceutil/trace.go:171","msg":"trace[1798759680] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4763; }","duration":"271.05143ms","start":"2026-05-27T00:47:17.43398Z","end":"2026-05-27T00:47:17.705031Z","steps":["trace[1798759680] 'agreement among raft nodes before linearized reading' (duration: 270.943248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.70508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.913837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-27T00:47:17.705149Z","caller":"traceutil/trace.go:171","msg":"trace[962114902] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4763; }","duration":"145.002678ms","start":"2026-05-27T00:47:17.560129Z","end":"2026-05-27T00:47:17.705132Z","steps":["trace[962114902] 'agreement among raft nodes before linearized reading' (duration: 144.784354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.705058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:16.840145Z","time spent":"864.879927ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-27T00:47:17.705414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.307626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-27T00:47:17.705463Z","caller":"traceutil/trace.go:171","msg":"trace[894968774] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4763; }","duration":"140.379927ms","start":"2026-05-27T00:47:17.56507Z","end":"2026-05-27T00:47:17.70545Z","steps":["trace[894968774] 'agreement among raft nodes before linearized reading' (duration: 140.272665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.705579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.396467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"warn","ts":"2026-05-27T00:47:17.705629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.932785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:17.705639Z","caller":"traceutil/trace.go:171","msg":"trace[960800886] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4763; }","duration":"747.463689ms","start":"2026-05-27T00:47:16.958162Z","end":"2026-05-27T00:47:17.705625Z","steps":["trace[960800886] 'agreement among raft nodes before linearized reading' (duration: 746.397882ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:17.70566Z","caller":"traceutil/trace.go:171","msg":"trace[490444535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4763; }","duration":"131.977566ms","start":"2026-05-27T00:47:17.573674Z","end":"2026-05-27T00:47:17.705651Z","steps":["trace[490444535] 'agreement among raft nodes before linearized reading' (duration: 131.928785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.705679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:16.958108Z","time spent":"747.559831ms","remote":"127.0.0.1:56168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206996,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-27T00:47:17.705809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.833354ms","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-05-27T00:47:17.705881Z","caller":"traceutil/trace.go:171","msg":"trace[1521014386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4763; }","duration":"508.949385ms","start":"2026-05-27T00:47:17.196917Z","end":"2026-05-27T00:47:17.705866Z","steps":["trace[1521014386] 'agreement among raft nodes before linearized reading' (duration: 508.750252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.705939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.196883Z","time spent":"509.044907ms","remote":"127.0.0.1:56304","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-05-27T00:47:17.705961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.512218ms","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-05-27T00:47:17.705991Z","caller":"traceutil/trace.go:171","msg":"trace[1652475501] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4763; }","duration":"508.564719ms","start":"2026-05-27T00:47:17.197418Z","end":"2026-05-27T00:47:17.705983Z","steps":["trace[1652475501] 'agreement among raft nodes before linearized reading' (duration: 508.450077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.706015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.197379Z","time spent":"508.6299ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T00:47:17.706262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.904495ms","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-05-27T00:47:17.706317Z","caller":"traceutil/trace.go:171","msg":"trace[1873169594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4763; }","duration":"508.971096ms","start":"2026-05-27T00:47:17.197331Z","end":"2026-05-27T00:47:17.706302Z","steps":["trace[1873169594] 'agreement among raft nodes before linearized reading' (duration: 508.841494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.706361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.197325Z","time spent":"509.026606ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T00:47:17.70637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.683776ms","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-05-27T00:47:17.706417Z","caller":"traceutil/trace.go:171","msg":"trace[1123711433] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4763; }","duration":"622.754847ms","start":"2026-05-27T00:47:17.083642Z","end":"2026-05-27T00:47:17.706397Z","steps":["trace[1123711433] 'agreement among raft nodes before linearized reading' (duration: 622.637725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.706448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.083626Z","time spent":"622.815428ms","remote":"127.0.0.1:56304","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-05-27T00:47:17.708156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.513455ms","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-05-27T00:47:17.708203Z","caller":"traceutil/trace.go:171","msg":"trace[1775035129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4763; }","duration":"511.587556ms","start":"2026-05-27T00:47:17.196604Z","end":"2026-05-27T00:47:17.708192Z","steps":["trace[1775035129] 'agreement among raft nodes before linearized reading' (duration: 509.683936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:17.708234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.196588Z","time spent":"511.639006ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T00:47:18.306439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.480236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:47:18.306568Z","caller":"traceutil/trace.go:171","msg":"trace[814223938] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"404.320004ms","start":"2026-05-27T00:47:17.902226Z","end":"2026-05-27T00:47:18.306546Z","steps":["trace[814223938] 'process raft request' (duration: 132.627265ms)","trace[814223938] 'compare' (duration: 271.261693ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:18.306555Z","caller":"traceutil/trace.go:171","msg":"trace[438193319] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4959; }","duration":"288.969739ms","start":"2026-05-27T00:47:18.01757Z","end":"2026-05-27T00:47:18.306539Z","steps":["trace[438193319] 'read index received' (duration: 17.234929ms)","trace[438193319] 'applied index is now lower than readState.Index' (duration: 271.73331ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:18.306662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:17.902209Z","time spent":"404.405485ms","remote":"127.0.0.1:43094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:47:18.3069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.330554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-27T00:47:18.307409Z","caller":"traceutil/trace.go:171","msg":"trace[1640324778] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4776; }","duration":"289.799672ms","start":"2026-05-27T00:47:18.017518Z","end":"2026-05-27T00:47:18.307318Z","steps":["trace[1640324778] 'agreement among raft nodes before linearized reading' (duration: 289.200753ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:18.532353Z","caller":"traceutil/trace.go:171","msg":"trace[780249180] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"125.778017ms","start":"2026-05-27T00:47:18.406546Z","end":"2026-05-27T00:47:18.532324Z","steps":["trace[780249180] 'process raft request' (duration: 84.40211ms)","trace[780249180] 'compare' (duration: 41.235375ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:18.837531Z","caller":"traceutil/trace.go:171","msg":"trace[248335660] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"201.40917ms","start":"2026-05-27T00:47:18.63609Z","end":"2026-05-27T00:47:18.837499Z","steps":["trace[248335660] 'process raft request' (duration: 201.311489ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:18.837625Z","caller":"traceutil/trace.go:171","msg":"trace[492232152] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"201.502241ms","start":"2026-05-27T00:47:18.636074Z","end":"2026-05-27T00:47:18.837576Z","steps":["trace[492232152] 'process raft request' (duration: 198.958261ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:18.839778Z","caller":"traceutil/trace.go:171","msg":"trace[626499354] linearizableReadLoop","detail":"{readStateIndex:4965; appliedIndex:4962; }","duration":"203.585563ms","start":"2026-05-27T00:47:18.63618Z","end":"2026-05-27T00:47:18.839765Z","steps":["trace[626499354] 'read index received' (duration: 198.86638ms)","trace[626499354] 'applied index is now lower than readState.Index' (duration: 4.718343ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:18.839945Z","caller":"traceutil/trace.go:171","msg":"trace[444549949] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"203.839467ms","start":"2026-05-27T00:47:18.636096Z","end":"2026-05-27T00:47:18.839935Z","steps":["trace[444549949] 'process raft request' (duration: 203.586363ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:18.840134Z","caller":"traceutil/trace.go:171","msg":"trace[584951854] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"202.68863ms","start":"2026-05-27T00:47:18.637438Z","end":"2026-05-27T00:47:18.840126Z","steps":["trace[584951854] 'process raft request' (duration: 202.296033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:18.840326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.130543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-27T00:47:18.840359Z","caller":"traceutil/trace.go:171","msg":"trace[475918833] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4782; }","duration":"204.203204ms","start":"2026-05-27T00:47:18.636146Z","end":"2026-05-27T00:47:18.84035Z","steps":["trace[475918833] 'agreement among raft nodes before linearized reading' (duration: 204.086052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:18.840498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.556205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa07e016-6897-4ddc-8c09-e1e4a02b4089\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-27T00:47:18.840523Z","caller":"traceutil/trace.go:171","msg":"trace[466416329] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa07e016-6897-4ddc-8c09-e1e4a02b4089; range_end:; response_count:1; response_revision:4782; }","duration":"127.615276ms","start":"2026-05-27T00:47:18.712902Z","end":"2026-05-27T00:47:18.840517Z","steps":["trace[466416329] 'agreement among raft nodes before linearized reading' (duration: 127.555225ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:23.974092Z","caller":"traceutil/trace.go:171","msg":"trace[1346518657] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"136.455144ms","start":"2026-05-27T00:47:23.837599Z","end":"2026-05-27T00:47:23.974054Z","steps":["trace[1346518657] 'process raft request' (duration: 85.804686ms)","trace[1346518657] 'compare' (duration: 50.344544ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:23.974051Z","caller":"traceutil/trace.go:171","msg":"trace[1868100678] linearizableReadLoop","detail":"{readStateIndex:5042; appliedIndex:5040; }","duration":"133.202213ms","start":"2026-05-27T00:47:23.840743Z","end":"2026-05-27T00:47:23.973946Z","steps":["trace[1868100678] 'read index received' (duration: 2.079252ms)","trace[1868100678] 'applied index is now lower than readState.Index' (duration: 131.121011ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:23.974744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.976724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:1716"} {"level":"info","ts":"2026-05-27T00:47:23.974885Z","caller":"traceutil/trace.go:171","msg":"trace[1231835734] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4855; }","duration":"134.114956ms","start":"2026-05-27T00:47:23.840712Z","end":"2026-05-27T00:47:23.974827Z","steps":["trace[1231835734] 'agreement among raft nodes before linearized reading' (duration: 133.438866ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:23.97504Z","caller":"traceutil/trace.go:171","msg":"trace[1593990790] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"120.975834ms","start":"2026-05-27T00:47:23.854043Z","end":"2026-05-27T00:47:23.975019Z","steps":["trace[1593990790] 'process raft request' (duration: 120.78214ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:31.640737Z","caller":"traceutil/trace.go:171","msg":"trace[454113171] linearizableReadLoop","detail":"{readStateIndex:5123; appliedIndex:5122; }","duration":"232.209599ms","start":"2026-05-27T00:47:31.4085Z","end":"2026-05-27T00:47:31.640709Z","steps":["trace[454113171] 'read index received' (duration: 231.983485ms)","trace[454113171] 'applied index is now lower than readState.Index' (duration: 225.054µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:31.640965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.443162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-05-27T00:47:31.641007Z","caller":"traceutil/trace.go:171","msg":"trace[1819115207] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4933; }","duration":"232.500063ms","start":"2026-05-27T00:47:31.408495Z","end":"2026-05-27T00:47:31.640995Z","steps":["trace[1819115207] 'agreement among raft nodes before linearized reading' (duration: 232.338411ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:31.641069Z","caller":"traceutil/trace.go:171","msg":"trace[665387662] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"237.391238ms","start":"2026-05-27T00:47:31.403533Z","end":"2026-05-27T00:47:31.640924Z","steps":["trace[665387662] 'process raft request' (duration: 237.004672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.141736Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679535663783977076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T00:47:32.83692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.037135ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-27T00:47:32.837277Z","caller":"traceutil/trace.go:171","msg":"trace[1253743101] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"1.075711163s","start":"2026-05-27T00:47:31.761546Z","end":"2026-05-27T00:47:32.837258Z","steps":["trace[1253743101] 'process raft request' (duration: 1.07548872s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.83738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.761528Z","time spent":"1.075793764s","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:32.837575Z","caller":"traceutil/trace.go:171","msg":"trace[175647652] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"1.073669631s","start":"2026-05-27T00:47:31.763891Z","end":"2026-05-27T00:47:32.837561Z","steps":["trace[175647652] 'process raft request' (duration: 1.073328596s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.837647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.763878Z","time spent":"1.073733253s","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:32.837693Z","caller":"traceutil/trace.go:171","msg":"trace[107741069] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"1.072709137s","start":"2026-05-27T00:47:31.764969Z","end":"2026-05-27T00:47:32.837678Z","steps":["trace[107741069] 'process raft request' (duration: 1.072468173s)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:32.837711Z","caller":"traceutil/trace.go:171","msg":"trace[2022794976] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"1.072560494s","start":"2026-05-27T00:47:31.76514Z","end":"2026-05-27T00:47:32.8377Z","steps":["trace[2022794976] 'process raft request' (duration: 1.072475673s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.837764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.764948Z","time spent":"1.072779318s","remote":"127.0.0.1:56304","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-05-27T00:47:32.837822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.765131Z","time spent":"1.072630076s","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:47:32.837884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261407271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:32.837986Z","caller":"traceutil/trace.go:171","msg":"trace[532797280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4937; }","duration":"1.261558234s","start":"2026-05-27T00:47:31.576405Z","end":"2026-05-27T00:47:32.837963Z","steps":["trace[532797280] 'agreement among raft nodes before linearized reading' (duration: 1.261389322s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.838055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.576373Z","time spent":"1.261667935s","remote":"127.0.0.1:56104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T00:47:32.837664Z","caller":"traceutil/trace.go:171","msg":"trace[269224576] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5123; }","duration":"1.196841174s","start":"2026-05-27T00:47:31.640805Z","end":"2026-05-27T00:47:32.837646Z","steps":["trace[269224576] 'read index received' (duration: 607.090828ms)","trace[269224576] 'applied index is now lower than readState.Index' (duration: 589.749666ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:32.838419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.972805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T00:47:32.838498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113330994s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-05-27T00:47:32.838499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.152324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-27T00:47:32.838519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.803228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-27T00:47:32.838594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.540033ms","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-05-27T00:47:32.838633Z","caller":"traceutil/trace.go:171","msg":"trace[605526749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4937; }","duration":"971.691526ms","start":"2026-05-27T00:47:31.866932Z","end":"2026-05-27T00:47:32.838624Z","steps":["trace[605526749] 'agreement among raft nodes before linearized reading' (duration: 971.514992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.838652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.67764ms","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:7"} {"level":"info","ts":"2026-05-27T00:47:32.838764Z","caller":"traceutil/trace.go:171","msg":"trace[877130914] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4937; }","duration":"577.827233ms","start":"2026-05-27T00:47:32.260926Z","end":"2026-05-27T00:47:32.838753Z","steps":["trace[877130914] 'agreement among raft nodes before linearized reading' (duration: 577.695211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.838807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:32.260906Z","time spent":"577.887614ms","remote":"127.0.0.1:34374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-27T00:47:32.838839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.933216ms","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-05-27T00:47:32.838907Z","caller":"traceutil/trace.go:171","msg":"trace[1978559595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4937; }","duration":"964.106449ms","start":"2026-05-27T00:47:31.874792Z","end":"2026-05-27T00:47:32.838899Z","steps":["trace[1978559595] 'agreement among raft nodes before linearized reading' (duration: 963.841945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.838956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.87478Z","time spent":"964.16805ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T00:47:32.838567Z","caller":"traceutil/trace.go:171","msg":"trace[1201209894] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4937; }","duration":"1.113415546s","start":"2026-05-27T00:47:31.72514Z","end":"2026-05-27T00:47:32.838556Z","steps":["trace[1201209894] 'agreement among raft nodes before linearized reading' (duration: 1.113317924s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.839125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.725128Z","time spent":"1.113983274s","remote":"127.0.0.1:56200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-05-27T00:47:32.838668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.8669Z","time spent":"971.757157ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T00:47:32.838595Z","caller":"traceutil/trace.go:171","msg":"trace[952276150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4937; }","duration":"963.265425ms","start":"2026-05-27T00:47:31.875318Z","end":"2026-05-27T00:47:32.838583Z","steps":["trace[952276150] 'agreement among raft nodes before linearized reading' (duration: 963.075352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.839333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.875307Z","time spent":"964.018727ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T00:47:32.838505Z","caller":"traceutil/trace.go:171","msg":"trace[1809709478] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:4937; }","duration":"240.108718ms","start":"2026-05-27T00:47:32.598385Z","end":"2026-05-27T00:47:32.838494Z","steps":["trace[1809709478] 'agreement among raft nodes before linearized reading' (duration: 239.969165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.838437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191976339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-27T00:47:32.83952Z","caller":"traceutil/trace.go:171","msg":"trace[2065107587] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4937; }","duration":"1.193086546s","start":"2026-05-27T00:47:31.646424Z","end":"2026-05-27T00:47:32.83951Z","steps":["trace[2065107587] 'agreement among raft nodes before linearized reading' (duration: 1.191932908s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.839549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.646406Z","time spent":"1.193134187s","remote":"127.0.0.1:56200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-05-27T00:47:32.838604Z","caller":"traceutil/trace.go:171","msg":"trace[315956695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4937; }","duration":"962.90054ms","start":"2026-05-27T00:47:31.875692Z","end":"2026-05-27T00:47:32.838593Z","steps":["trace[315956695] 'agreement among raft nodes before linearized reading' (duration: 962.729996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.839658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.875688Z","time spent":"963.963327ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T00:47:32.838664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.192044441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b345a134e5ac4c\" ","response":"range_response_count:1 size:740"} {"level":"warn","ts":"2026-05-27T00:47:32.839754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.066778ms","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-05-27T00:47:32.839804Z","caller":"traceutil/trace.go:171","msg":"trace[1708499222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4937; }","duration":"964.136189ms","start":"2026-05-27T00:47:31.875655Z","end":"2026-05-27T00:47:32.839791Z","steps":["trace[1708499222] 'agreement among raft nodes before linearized reading' (duration: 962.963801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.839846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.875648Z","time spent":"964.189459ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T00:47:32.840042Z","caller":"traceutil/trace.go:171","msg":"trace[918126599] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b345a134e5ac4c; range_end:; response_count:1; response_revision:4937; }","duration":"1.193246569s","start":"2026-05-27T00:47:31.646538Z","end":"2026-05-27T00:47:32.839785Z","steps":["trace[918126599] 'agreement among raft nodes before linearized reading' (duration: 1.19204242s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.840087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:31.646519Z","time spent":"1.193557034s","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":763,"request content":"key:\"/registry/events/openstack/rabbitmq-keystone.18b345a134e5ac4c\" "} {"level":"info","ts":"2026-05-27T00:47:32.988531Z","caller":"traceutil/trace.go:171","msg":"trace[948468557] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"143.505376ms","start":"2026-05-27T00:47:32.845003Z","end":"2026-05-27T00:47:32.988508Z","steps":["trace[948468557] 'process raft request' (duration: 143.414414ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:32.988744Z","caller":"traceutil/trace.go:171","msg":"trace[782548304] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"143.714959ms","start":"2026-05-27T00:47:32.84502Z","end":"2026-05-27T00:47:32.988735Z","steps":["trace[782548304] 'process raft request' (duration: 143.454835ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:32.988578Z","caller":"traceutil/trace.go:171","msg":"trace[1765665040] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"143.602417ms","start":"2026-05-27T00:47:32.844956Z","end":"2026-05-27T00:47:32.988558Z","steps":["trace[1765665040] 'process raft request' (duration: 136.054811ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:32.988929Z","caller":"traceutil/trace.go:171","msg":"trace[105276957] linearizableReadLoop","detail":"{readStateIndex:5134; appliedIndex:5128; }","duration":"138.493228ms","start":"2026-05-27T00:47:32.850425Z","end":"2026-05-27T00:47:32.988918Z","steps":["trace[105276957] 'read index received' (duration: 58.329071ms)","trace[105276957] 'applied index is now lower than readState.Index' (duration: 80.163217ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:32.989006Z","caller":"traceutil/trace.go:171","msg":"trace[859077390] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"141.437713ms","start":"2026-05-27T00:47:32.847558Z","end":"2026-05-27T00:47:32.988995Z","steps":["trace[859077390] 'process raft request' (duration: 141.139538ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:32.989139Z","caller":"traceutil/trace.go:171","msg":"trace[1599771328] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"140.476749ms","start":"2026-05-27T00:47:32.84865Z","end":"2026-05-27T00:47:32.989127Z","steps":["trace[1599771328] 'process raft request' (duration: 140.228365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.989286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.843313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:32.989338Z","caller":"traceutil/trace.go:171","msg":"trace[1463411274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4943; }","duration":"138.918635ms","start":"2026-05-27T00:47:32.850394Z","end":"2026-05-27T00:47:32.989313Z","steps":["trace[1463411274] 'agreement among raft nodes before linearized reading' (duration: 138.814793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:32.989696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.954109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-05-27T00:47:32.989833Z","caller":"traceutil/trace.go:171","msg":"trace[308371406] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4943; }","duration":"138.096043ms","start":"2026-05-27T00:47:32.851718Z","end":"2026-05-27T00:47:32.989814Z","steps":["trace[308371406] 'agreement among raft nodes before linearized reading' (duration: 137.778588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:33.462748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.88318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:33.462817Z","caller":"traceutil/trace.go:171","msg":"trace[1817273973] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:4944; }","duration":"273.027992ms","start":"2026-05-27T00:47:33.189771Z","end":"2026-05-27T00:47:33.462799Z","steps":["trace[1817273973] 'count revisions from in-memory index tree' (duration: 272.801828ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:35.05212Z","caller":"traceutil/trace.go:171","msg":"trace[422176704] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"205.007389ms","start":"2026-05-27T00:47:34.847083Z","end":"2026-05-27T00:47:35.05209Z","steps":["trace[422176704] 'process raft request' (duration: 136.455692ms)","trace[422176704] 'compare' (duration: 68.013388ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:35.052707Z","caller":"traceutil/trace.go:171","msg":"trace[62637273] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"202.706084ms","start":"2026-05-27T00:47:34.849993Z","end":"2026-05-27T00:47:35.052699Z","steps":["trace[62637273] 'process raft request' (duration: 202.529041ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:35.05283Z","caller":"traceutil/trace.go:171","msg":"trace[1521532296] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"205.223002ms","start":"2026-05-27T00:47:34.847557Z","end":"2026-05-27T00:47:35.05278Z","steps":["trace[1521532296] 'process raft request' (duration: 204.46562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.585288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.11345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:47:35.585401Z","caller":"traceutil/trace.go:171","msg":"trace[782545988] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"527.485383ms","start":"2026-05-27T00:47:35.057896Z","end":"2026-05-27T00:47:35.585381Z","steps":["trace[782545988] 'process raft request' (duration: 205.20383ms)","trace[782545988] 'compare' (duration: 322.006288ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:35.585459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.057878Z","time spent":"527.554804ms","remote":"127.0.0.1:56304","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-05-27T00:47:35.849905Z","caller":"traceutil/trace.go:171","msg":"trace[871796838] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"791.56338ms","start":"2026-05-27T00:47:35.058321Z","end":"2026-05-27T00:47:35.849884Z","steps":["trace[871796838] 'process raft request' (duration: 791.454248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.058304Z","time spent":"791.656822ms","remote":"127.0.0.1:56304","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-05-27T00:47:35.850122Z","caller":"traceutil/trace.go:171","msg":"trace[479288743] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"791.722763ms","start":"2026-05-27T00:47:35.05839Z","end":"2026-05-27T00:47:35.850113Z","steps":["trace[479288743] 'process raft request' (duration: 791.462448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.058355Z","time spent":"791.788094ms","remote":"127.0.0.1:56304","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-05-27T00:47:35.850166Z","caller":"traceutil/trace.go:171","msg":"trace[1367540118] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"298.241294ms","start":"2026-05-27T00:47:35.551899Z","end":"2026-05-27T00:47:35.850141Z","steps":["trace[1367540118] 'process raft request' (duration: 298.141942ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:35.849941Z","caller":"traceutil/trace.go:171","msg":"trace[1161867596] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"791.643931ms","start":"2026-05-27T00:47:35.058257Z","end":"2026-05-27T00:47:35.849901Z","steps":["trace[1161867596] 'process raft request' (duration: 714.827728ms)","trace[1161867596] 'compare' (duration: 76.394477ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:35.85036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.250178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:35.850392Z","caller":"traceutil/trace.go:171","msg":"trace[1546755909] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:4954; }","duration":"447.286498ms","start":"2026-05-27T00:47:35.403098Z","end":"2026-05-27T00:47:35.850385Z","steps":["trace[1546755909] 'agreement among raft nodes before linearized reading' (duration: 447.231817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.403072Z","time spent":"447.334099ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-05-27T00:47:35.850288Z","caller":"traceutil/trace.go:171","msg":"trace[1393036465] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"790.957522ms","start":"2026-05-27T00:47:35.05932Z","end":"2026-05-27T00:47:35.850277Z","steps":["trace[1393036465] 'process raft request' (duration: 790.614256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.05931Z","time spent":"791.190105ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:47:35.850315Z","caller":"traceutil/trace.go:171","msg":"trace[1064028441] linearizableReadLoop","detail":"{readStateIndex:5144; appliedIndex:5140; }","duration":"447.183606ms","start":"2026-05-27T00:47:35.403126Z","end":"2026-05-27T00:47:35.850309Z","steps":["trace[1064028441] 'read index received' (duration: 369.972877ms)","trace[1064028441] 'applied index is now lower than readState.Index' (duration: 77.210069ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:35.850661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.74338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:47:35.850711Z","caller":"traceutil/trace.go:171","msg":"trace[617578628] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4954; }","duration":"335.816942ms","start":"2026-05-27T00:47:35.51487Z","end":"2026-05-27T00:47:35.850687Z","steps":["trace[617578628] 'agreement among raft nodes before linearized reading' (duration: 335.768991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.514843Z","time spent":"335.883322ms","remote":"127.0.0.1:56196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-27T00:47:35.850787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.835111ms","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-05-27T00:47:35.850858Z","caller":"traceutil/trace.go:171","msg":"trace[1962653039] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4954; }","duration":"120.978403ms","start":"2026-05-27T00:47:35.729864Z","end":"2026-05-27T00:47:35.850843Z","steps":["trace[1962653039] 'agreement among raft nodes before linearized reading' (duration: 120.846401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.850906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.953492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:47:35.850964Z","caller":"traceutil/trace.go:171","msg":"trace[1355414628] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4954; }","duration":"217.020023ms","start":"2026-05-27T00:47:35.633932Z","end":"2026-05-27T00:47:35.850952Z","steps":["trace[1355414628] 'agreement among raft nodes before linearized reading' (duration: 216.86688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:35.85172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:47:35.058249Z","time spent":"792.126259ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:48:33.304773Z","caller":"traceutil/trace.go:171","msg":"trace[1211435564] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"206.13753ms","start":"2026-05-27T00:48:33.098606Z","end":"2026-05-27T00:48:33.304744Z","steps":["trace[1211435564] 'process raft request' (duration: 205.982158ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:33.574734Z","caller":"traceutil/trace.go:171","msg":"trace[1103943570] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"472.946379ms","start":"2026-05-27T00:48:33.101758Z","end":"2026-05-27T00:48:33.574704Z","steps":["trace[1103943570] 'process raft request' (duration: 472.758805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:33.57488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.10173Z","time spent":"473.086922ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:48:33.746995Z","caller":"traceutil/trace.go:171","msg":"trace[295204247] linearizableReadLoop","detail":"{readStateIndex:5634; appliedIndex:5630; }","duration":"317.272105ms","start":"2026-05-27T00:48:33.429708Z","end":"2026-05-27T00:48:33.74698Z","steps":["trace[295204247] 'read index received' (duration: 144.881824ms)","trace[295204247] 'applied index is now lower than readState.Index' (duration: 172.389671ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:48:33.747078Z","caller":"traceutil/trace.go:171","msg":"trace[1868985426] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"361.267366ms","start":"2026-05-27T00:48:33.385803Z","end":"2026-05-27T00:48:33.74707Z","steps":["trace[1868985426] 'process raft request' (duration: 361.150264ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:33.747046Z","caller":"traceutil/trace.go:171","msg":"trace[166804330] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"371.01186ms","start":"2026-05-27T00:48:33.375979Z","end":"2026-05-27T00:48:33.74699Z","steps":["trace[166804330] 'process raft request' (duration: 370.948129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:33.747188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.375953Z","time spent":"371.160702ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:48:33.747333Z","caller":"traceutil/trace.go:171","msg":"trace[1629778756] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"430.45268ms","start":"2026-05-27T00:48:33.316864Z","end":"2026-05-27T00:48:33.747317Z","steps":["trace[1629778756] 'process raft request' (duration: 406.397524ms)","trace[1629778756] 'compare' (duration: 23.576239ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:48:33.747399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.316821Z","time spent":"430.542191ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:48:33.747355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.729791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:48:33.747507Z","caller":"traceutil/trace.go:171","msg":"trace[536673611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5429; }","duration":"171.906523ms","start":"2026-05-27T00:48:33.575583Z","end":"2026-05-27T00:48:33.747489Z","steps":["trace[536673611] 'agreement among raft nodes before linearized reading' (duration: 171.726791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:33.74752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.198937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:48:33.747602Z","caller":"traceutil/trace.go:171","msg":"trace[712883208] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5429; }","duration":"201.475501ms","start":"2026-05-27T00:48:33.546111Z","end":"2026-05-27T00:48:33.747586Z","steps":["trace[712883208] 'agreement among raft nodes before linearized reading' (duration: 201.165497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:33.747146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.385786Z","time spent":"361.308316ms","remote":"127.0.0.1:56304","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-05-27T00:48:33.747544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.836873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:48:33.747946Z","caller":"traceutil/trace.go:171","msg":"trace[1499906810] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:5429; }","duration":"318.264859ms","start":"2026-05-27T00:48:33.429657Z","end":"2026-05-27T00:48:33.747922Z","steps":["trace[1499906810] 'agreement among raft nodes before linearized reading' (duration: 317.841563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:33.748058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.429635Z","time spent":"318.392111ms","remote":"127.0.0.1:37208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-27T00:48:33.74764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.958163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:48:33.748225Z","caller":"traceutil/trace.go:171","msg":"trace[418114542] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5429; }","duration":"201.611762ms","start":"2026-05-27T00:48:33.546595Z","end":"2026-05-27T00:48:33.748207Z","steps":["trace[418114542] 'agreement among raft nodes before linearized reading' (duration: 200.955323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.509334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.467738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T00:48:34.509568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.072537ms","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-05-27T00:48:34.509684Z","caller":"traceutil/trace.go:171","msg":"trace[1814632495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5429; }","duration":"281.242899ms","start":"2026-05-27T00:48:34.228412Z","end":"2026-05-27T00:48:34.509655Z","steps":["trace[1814632495] 'range keys from in-memory index tree' (duration: 280.817363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.509801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.816423ms","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-05-27T00:48:34.509885Z","caller":"traceutil/trace.go:171","msg":"trace[919461787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5429; }","duration":"167.909114ms","start":"2026-05-27T00:48:34.341957Z","end":"2026-05-27T00:48:34.509866Z","steps":["trace[919461787] 'range keys from in-memory index tree' (duration: 167.631889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.509911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.040397ms","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-05-27T00:48:34.509979Z","caller":"traceutil/trace.go:171","msg":"trace[724398015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5429; }","duration":"156.152829ms","start":"2026-05-27T00:48:34.353811Z","end":"2026-05-27T00:48:34.509964Z","steps":["trace[724398015] 'range keys from in-memory index tree' (duration: 155.897365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.510519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.342842ms","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-05-27T00:48:34.510566Z","caller":"traceutil/trace.go:171","msg":"trace[145195231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5429; }","duration":"231.430113ms","start":"2026-05-27T00:48:34.279124Z","end":"2026-05-27T00:48:34.510555Z","steps":["trace[145195231] 'range keys from in-memory index tree' (duration: 231.084138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.510611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.09699ms","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-05-27T00:48:34.510682Z","caller":"traceutil/trace.go:171","msg":"trace[615505803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5429; }","duration":"632.203631ms","start":"2026-05-27T00:48:33.878461Z","end":"2026-05-27T00:48:34.510664Z","steps":["trace[615505803] 'range keys from in-memory index tree' (duration: 630.79736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.51071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.461894ms","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":"warn","ts":"2026-05-27T00:48:34.510739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:33.878444Z","time spent":"632.281703ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T00:48:34.510783Z","caller":"traceutil/trace.go:171","msg":"trace[785977458] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5429; }","duration":"131.538025ms","start":"2026-05-27T00:48:34.379233Z","end":"2026-05-27T00:48:34.510771Z","steps":["trace[785977458] 'count revisions from in-memory index tree' (duration: 131.392504ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:34.509613Z","caller":"traceutil/trace.go:171","msg":"trace[1272654069] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:5429; }","duration":"332.797692ms","start":"2026-05-27T00:48:34.176785Z","end":"2026-05-27T00:48:34.509583Z","steps":["trace[1272654069] 'count revisions from in-memory index tree' (duration: 332.386975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:48:34.511602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:48:34.176766Z","time spent":"334.812323ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"info","ts":"2026-05-27T00:48:34.640278Z","caller":"traceutil/trace.go:171","msg":"trace[665860754] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"124.696785ms","start":"2026-05-27T00:48:34.515561Z","end":"2026-05-27T00:48:34.640258Z","steps":["trace[665860754] 'process raft request' (duration: 119.454987ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:34.64066Z","caller":"traceutil/trace.go:171","msg":"trace[2077785313] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"124.995569ms","start":"2026-05-27T00:48:34.515646Z","end":"2026-05-27T00:48:34.640642Z","steps":["trace[2077785313] 'process raft request' (duration: 124.578553ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:34.64088Z","caller":"traceutil/trace.go:171","msg":"trace[1879977496] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"125.138922ms","start":"2026-05-27T00:48:34.515665Z","end":"2026-05-27T00:48:34.640804Z","steps":["trace[1879977496] 'process raft request' (duration: 124.795157ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:34.641047Z","caller":"traceutil/trace.go:171","msg":"trace[1863931039] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"124.793115ms","start":"2026-05-27T00:48:34.516245Z","end":"2026-05-27T00:48:34.641038Z","steps":["trace[1863931039] 'process raft request' (duration: 124.390479ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:43.254835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862} {"level":"info","ts":"2026-05-27T00:48:43.364361Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"108.576878ms","hash":1329754495,"current-db-size-bytes":53792768,"current-db-size":"54 MB","current-db-size-in-use-bytes":29061120,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-27T00:48:43.364429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1329754495,"revision":2862,"compact-revision":-1} {"level":"warn","ts":"2026-05-27T00:48:46.537172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.355284ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-27T00:48:46.537472Z","caller":"traceutil/trace.go:171","msg":"trace[1002314239] linearizableReadLoop","detail":"{readStateIndex:5737; appliedIndex:5735; }","duration":"145.288075ms","start":"2026-05-27T00:48:46.392161Z","end":"2026-05-27T00:48:46.537449Z","steps":["trace[1002314239] 'read index received' (duration: 38.640668ms)","trace[1002314239] 'applied index is now lower than readState.Index' (duration: 106.646097ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:48:46.537625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.477468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:48:46.537671Z","caller":"traceutil/trace.go:171","msg":"trace[699112004] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5528; }","duration":"145.5821ms","start":"2026-05-27T00:48:46.392077Z","end":"2026-05-27T00:48:46.537659Z","steps":["trace[699112004] 'agreement among raft nodes before linearized reading' (duration: 145.443818ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:46.53767Z","caller":"traceutil/trace.go:171","msg":"trace[314027412] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"153.546727ms","start":"2026-05-27T00:48:46.384084Z","end":"2026-05-27T00:48:46.537631Z","steps":["trace[314027412] 'process raft request' (duration: 153.222542ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:49:26.150057Z","caller":"traceutil/trace.go:171","msg":"trace[1145139348] transaction","detail":"{read_only:false; response_revision:5802; number_of_response:1; }","duration":"123.636125ms","start":"2026-05-27T00:49:26.02639Z","end":"2026-05-27T00:49:26.150026Z","steps":["trace[1145139348] 'process raft request' (duration: 123.577304ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:49:26.15025Z","caller":"traceutil/trace.go:171","msg":"trace[1307367569] transaction","detail":"{read_only:false; response_revision:5801; number_of_response:1; }","duration":"134.754476ms","start":"2026-05-27T00:49:26.015464Z","end":"2026-05-27T00:49:26.150218Z","steps":["trace[1307367569] 'process raft request' (duration: 96.475874ms)","trace[1307367569] 'compare' (duration: 37.906127ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:50:16.476141Z","caller":"traceutil/trace.go:171","msg":"trace[1578458622] transaction","detail":"{read_only:false; response_revision:6065; number_of_response:1; }","duration":"153.177748ms","start":"2026-05-27T00:50:16.32292Z","end":"2026-05-27T00:50:16.476097Z","steps":["trace[1578458622] 'process raft request' (duration: 152.378597ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:50:16.476664Z","caller":"traceutil/trace.go:171","msg":"trace[408563266] linearizableReadLoop","detail":"{readStateIndex:6293; appliedIndex:6291; }","duration":"107.253716ms","start":"2026-05-27T00:50:16.369385Z","end":"2026-05-27T00:50:16.476639Z","steps":["trace[408563266] 'read index received' (duration: 105.925267ms)","trace[408563266] 'applied index is now lower than readState.Index' (duration: 1.327269ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:50:16.476879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.473589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.137\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-27T00:50:16.476923Z","caller":"traceutil/trace.go:171","msg":"trace[566220642] range","detail":"{range_begin:/registry/masterleases/199.19.213.137; range_end:; response_count:1; response_revision:6066; }","duration":"107.56912ms","start":"2026-05-27T00:50:16.369342Z","end":"2026-05-27T00:50:16.476912Z","steps":["trace[566220642] 'agreement among raft nodes before linearized reading' (duration: 107.397848ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:50:16.477297Z","caller":"traceutil/trace.go:171","msg":"trace[832232920] transaction","detail":"{read_only:false; response_revision:6066; number_of_response:1; }","duration":"154.299514ms","start":"2026-05-27T00:50:16.322962Z","end":"2026-05-27T00:50:16.477262Z","steps":["trace[832232920] 'process raft request' (duration: 153.584133ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:51:18.022502Z","caller":"traceutil/trace.go:171","msg":"trace[1804955301] transaction","detail":"{read_only:false; response_revision:6568; number_of_response:1; }","duration":"112.186968ms","start":"2026-05-27T00:51:17.91029Z","end":"2026-05-27T00:51:18.022476Z","steps":["trace[1804955301] 'process raft request' (duration: 112.007572ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:51:18.926166Z","caller":"traceutil/trace.go:171","msg":"trace[1877880684] transaction","detail":"{read_only:false; response_revision:6570; number_of_response:1; }","duration":"229.836958ms","start":"2026-05-27T00:51:18.696305Z","end":"2026-05-27T00:51:18.926142Z","steps":["trace[1877880684] 'process raft request' (duration: 229.631452ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:51:18.927144Z","caller":"traceutil/trace.go:171","msg":"trace[1215736319] linearizableReadLoop","detail":"{readStateIndex:6814; appliedIndex:6812; }","duration":"201.589984ms","start":"2026-05-27T00:51:18.725535Z","end":"2026-05-27T00:51:18.927125Z","steps":["trace[1215736319] 'read index received' (duration: 200.42004ms)","trace[1215736319] 'applied index is now lower than readState.Index' (duration: 1.168784ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:51:18.92736Z","caller":"traceutil/trace.go:171","msg":"trace[1437991209] transaction","detail":"{read_only:false; response_revision:6571; number_of_response:1; }","duration":"229.398355ms","start":"2026-05-27T00:51:18.697951Z","end":"2026-05-27T00:51:18.927349Z","steps":["trace[1437991209] 'process raft request' (duration: 229.110656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:51:18.927582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.035227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-05-27T00:51:18.927621Z","caller":"traceutil/trace.go:171","msg":"trace[1512184346] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6571; }","duration":"202.11178ms","start":"2026-05-27T00:51:18.7255Z","end":"2026-05-27T00:51:18.927612Z","steps":["trace[1512184346] 'agreement among raft nodes before linearized reading' (duration: 201.982516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:51:18.92783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.979459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-05-27T00:51:18.927864Z","caller":"traceutil/trace.go:171","msg":"trace[373234449] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6571; }","duration":"165.050562ms","start":"2026-05-27T00:51:18.762806Z","end":"2026-05-27T00:51:18.927856Z","steps":["trace[373234449] 'agreement among raft nodes before linearized reading' (duration: 164.968509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:51:42.385862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.940678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107255"} {"level":"info","ts":"2026-05-27T00:51:42.385938Z","caller":"traceutil/trace.go:171","msg":"trace[39685721] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6747; }","duration":"124.02726ms","start":"2026-05-27T00:51:42.261897Z","end":"2026-05-27T00:51:42.385924Z","steps":["trace[39685721] 'range keys from in-memory index tree' (duration: 123.813645ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:53:43.260951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5506} {"level":"info","ts":"2026-05-27T00:53:43.368382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5506,"took":"105.84784ms","hash":13158842,"current-db-size-bytes":53792768,"current-db-size":"54 MB","current-db-size-in-use-bytes":18493440,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-27T00:53:43.368459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":13158842,"revision":5506,"compact-revision":2862}