{"level":"warn","ts":"2026-06-09T17:05:45.390813Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T17:05:45.390908Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.240: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.240:2380","--initial-cluster=instance=https://199.19.213.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.240:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-09T17:05:45.391004Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T17:05:45.391018Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.240:2380"]} {"level":"info","ts":"2026-06-09T17:05:45.391043Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-09T17:05:45.391935Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"]} {"level":"info","ts":"2026-06-09T17:05:45.392027Z","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.240:2380"],"listen-peer-urls":["https://199.19.213.240:2380"],"advertise-client-urls":["https://199.19.213.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.240:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-09T17:05:45.396425Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.934969ms"} {"level":"info","ts":"2026-06-09T17:05:45.401843Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"65ae7913d9d30912","cluster-id":"74cb0f8fbd7d5970"} {"level":"info","ts":"2026-06-09T17:05:45.401909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T17:05:45.401932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became follower at term 0"} {"level":"info","ts":"2026-06-09T17:05:45.401946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 65ae7913d9d30912 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T17:05:45.401959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became follower at term 1"} {"level":"info","ts":"2026-06-09T17:05:45.402004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=(7326926769944201490)"} {"level":"warn","ts":"2026-06-09T17:05:45.408627Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T17:05:45.409997Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T17:05:45.411243Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-09T17:05:45.413364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"65ae7913d9d30912","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T17:05:45.414366Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T17:05:45.415579Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"65ae7913d9d30912","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T17:05:45.415622Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T17:05:45.415713Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T17:05:45.416102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=(7326926769944201490)"} {"level":"info","ts":"2026-06-09T17:05:45.417971Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-09T17:05:45.418318Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"65ae7913d9d30912","initial-advertise-peer-urls":["https://199.19.213.240:2380"],"listen-peer-urls":["https://199.19.213.240:2380"],"advertise-client-urls":["https://199.19.213.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T17:05:45.418383Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T17:05:45.418492Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"74cb0f8fbd7d5970","local-member-id":"65ae7913d9d30912","added-peer-id":"65ae7913d9d30912","added-peer-peer-urls":["https://199.19.213.240:2380"]} {"level":"info","ts":"2026-06-09T17:05:45.418658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.240:2380"} {"level":"info","ts":"2026-06-09T17:05:45.418706Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.240:2380"} {"level":"info","ts":"2026-06-09T17:05:45.802164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T17:05:45.802237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T17:05:45.802346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 received MsgPreVoteResp from 65ae7913d9d30912 at term 1"} {"level":"info","ts":"2026-06-09T17:05:45.802376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became candidate at term 2"} {"level":"info","ts":"2026-06-09T17:05:45.80239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 received MsgVoteResp from 65ae7913d9d30912 at term 2"} {"level":"info","ts":"2026-06-09T17:05:45.802421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became leader at term 2"} {"level":"info","ts":"2026-06-09T17:05:45.802438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 65ae7913d9d30912 elected leader 65ae7913d9d30912 at term 2"} {"level":"info","ts":"2026-06-09T17:05:45.80371Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"65ae7913d9d30912","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.240:2379]}","request-path":"/0/members/65ae7913d9d30912/attributes","cluster-id":"74cb0f8fbd7d5970","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T17:05:45.803734Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:05:45.803779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:05:45.803867Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:05:45.804819Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T17:05:45.804868Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T17:05:45.80595Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T17:05:45.806801Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.240:2379"} {"level":"info","ts":"2026-06-09T17:05:45.820144Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"74cb0f8fbd7d5970","local-member-id":"65ae7913d9d30912","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:05:45.820229Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:05:45.820252Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:06:19.575852Z","caller":"traceutil/trace.go:171","msg":"trace[1169753613] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"167.667389ms","start":"2026-06-09T17:06:19.408165Z","end":"2026-06-09T17:06:19.575833Z","steps":["trace[1169753613] 'process raft request' (duration: 167.571299ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.753725Z","caller":"traceutil/trace.go:171","msg":"trace[1270081608] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"412.11839ms","start":"2026-06-09T17:06:28.341574Z","end":"2026-06-09T17:06:28.753692Z","steps":["trace[1270081608] 'process raft request' (duration: 412.014175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.754299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.341549Z","time spent":"412.342672ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.759772Z","caller":"traceutil/trace.go:171","msg":"trace[1904122288] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"403.528982ms","start":"2026-06-09T17:06:28.35622Z","end":"2026-06-09T17:06:28.759749Z","steps":["trace[1904122288] 'process raft request' (duration: 403.29445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.759926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.356194Z","time spent":"403.647719ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.760087Z","caller":"traceutil/trace.go:171","msg":"trace[457023257] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"387.562605ms","start":"2026-06-09T17:06:28.372493Z","end":"2026-06-09T17:06:28.760055Z","steps":["trace[457023257] 'process raft request' (duration: 387.137954ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760131Z","caller":"traceutil/trace.go:171","msg":"trace[1780093894] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:523; }","duration":"402.394603ms","start":"2026-06-09T17:06:28.357713Z","end":"2026-06-09T17:06:28.760107Z","steps":["trace[1780093894] 'read index received' (duration: 395.895091ms)","trace[1780093894] 'applied index is now lower than readState.Index' (duration: 6.498572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:28.760192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.372487Z","time spent":"387.65441ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.760198Z","caller":"traceutil/trace.go:171","msg":"trace[1647584153] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"364.544728ms","start":"2026-06-09T17:06:28.395626Z","end":"2026-06-09T17:06:28.760171Z","steps":["trace[1647584153] 'process raft request' (duration: 364.151019ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760237Z","caller":"traceutil/trace.go:171","msg":"trace[1199202302] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"344.505264ms","start":"2026-06-09T17:06:28.415717Z","end":"2026-06-09T17:06:28.760223Z","steps":["trace[1199202302] 'process raft request' (duration: 344.131405ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760261Z","caller":"traceutil/trace.go:171","msg":"trace[757646168] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"398.160627ms","start":"2026-06-09T17:06:28.362066Z","end":"2026-06-09T17:06:28.760226Z","steps":["trace[757646168] 'process raft request' (duration: 397.489364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.760326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.395608Z","time spent":"364.651725ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:06:28.760337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.415702Z","time spent":"344.563208ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.760341Z","caller":"traceutil/trace.go:171","msg":"trace[893442256] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"388.923285ms","start":"2026-06-09T17:06:28.371389Z","end":"2026-06-09T17:06:28.760312Z","steps":["trace[893442256] 'process raft request' (duration: 388.208419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.760345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.362052Z","time spent":"398.249243ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:06:28.760415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.37137Z","time spent":"389.01279ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.760442Z","caller":"traceutil/trace.go:171","msg":"trace[614532524] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"383.656225ms","start":"2026-06-09T17:06:28.376779Z","end":"2026-06-09T17:06:28.760435Z","steps":["trace[614532524] 'process raft request' (duration: 382.888976ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760459Z","caller":"traceutil/trace.go:171","msg":"trace[2041692562] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"371.702845ms","start":"2026-06-09T17:06:28.388746Z","end":"2026-06-09T17:06:28.760448Z","steps":["trace[2041692562] 'process raft request' (duration: 370.967137ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760469Z","caller":"traceutil/trace.go:171","msg":"trace[1559641408] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"244.046609ms","start":"2026-06-09T17:06:28.516412Z","end":"2026-06-09T17:06:28.760459Z","steps":["trace[1559641408] 'process raft request' (duration: 243.631827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.76048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.376772Z","time spent":"383.690538ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:06:28.760504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.388727Z","time spent":"371.757738ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.760576Z","caller":"traceutil/trace.go:171","msg":"trace[965367174] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"414.911235ms","start":"2026-06-09T17:06:28.34559Z","end":"2026-06-09T17:06:28.760501Z","steps":["trace[965367174] 'process raft request' (duration: 413.803178ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:28.760126Z","caller":"traceutil/trace.go:171","msg":"trace[30087002] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"417.762069ms","start":"2026-06-09T17:06:28.342328Z","end":"2026-06-09T17:06:28.76009Z","steps":["trace[30087002] 'process raft request' (duration: 416.964259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.760745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.91033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-09T17:06:28.761111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.342303Z","time spent":"418.667186ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:06:28.761131Z","caller":"traceutil/trace.go:171","msg":"trace[1512112325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"403.444208ms","start":"2026-06-09T17:06:28.35767Z","end":"2026-06-09T17:06:28.761115Z","steps":["trace[1512112325] 'agreement among raft nodes before linearized reading' (duration: 402.859398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.761164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.34556Z","time spent":"415.369927ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:06:28.761196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.357658Z","time spent":"403.521672ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T17:06:28.764226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.472362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:06:28.764267Z","caller":"traceutil/trace.go:171","msg":"trace[1692577607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"406.521364ms","start":"2026-06-09T17:06:28.357737Z","end":"2026-06-09T17:06:28.764258Z","steps":["trace[1692577607] 'agreement among raft nodes before linearized reading' (duration: 406.43828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:28.764289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:28.357734Z","time spent":"406.549836ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T17:06:29.937432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.626203ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:06:29.937595Z","caller":"traceutil/trace.go:171","msg":"trace[631306769] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"267.728485ms","start":"2026-06-09T17:06:29.669824Z","end":"2026-06-09T17:06:29.937552Z","steps":["trace[631306769] 'process raft request' (duration: 91.759086ms)","trace[631306769] 'compare' (duration: 175.422792ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:06:29.937679Z","caller":"traceutil/trace.go:171","msg":"trace[993076556] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"164.815626ms","start":"2026-06-09T17:06:29.772816Z","end":"2026-06-09T17:06:29.937631Z","steps":["trace[993076556] 'read index received' (duration: 27.241µs)","trace[993076556] 'applied index is now lower than readState.Index' (duration: 164.785325ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:29.938042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.211517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-06-09T17:06:29.93808Z","caller":"traceutil/trace.go:171","msg":"trace[439230425] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:581; }","duration":"165.299031ms","start":"2026-06-09T17:06:29.77277Z","end":"2026-06-09T17:06:29.938069Z","steps":["trace[439230425] 'agreement among raft nodes before linearized reading' (duration: 164.960243ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:29.93808Z","caller":"traceutil/trace.go:171","msg":"trace[858887632] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"140.872116ms","start":"2026-06-09T17:06:29.797187Z","end":"2026-06-09T17:06:29.938059Z","steps":["trace[858887632] 'process raft request' (duration: 140.468676ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:34.805899Z","caller":"traceutil/trace.go:171","msg":"trace[571721526] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"164.474544ms","start":"2026-06-09T17:06:34.6414Z","end":"2026-06-09T17:06:34.805874Z","steps":["trace[571721526] 'process raft request' (duration: 163.703798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:35.15695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.724629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:06:35.157165Z","caller":"traceutil/trace.go:171","msg":"trace[196728700] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:636; }","duration":"189.788556ms","start":"2026-06-09T17:06:34.967359Z","end":"2026-06-09T17:06:35.157148Z","steps":["trace[196728700] 'read index received' (duration: 74.141591ms)","trace[196728700] 'applied index is now lower than readState.Index' (duration: 115.645945ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:35.157325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.960704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:06:35.157365Z","caller":"traceutil/trace.go:171","msg":"trace[798649083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"190.026668ms","start":"2026-06-09T17:06:34.967327Z","end":"2026-06-09T17:06:35.157354Z","steps":["trace[798649083] 'agreement among raft nodes before linearized reading' (duration: 189.874111ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:35.157563Z","caller":"traceutil/trace.go:171","msg":"trace[393222897] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"345.313303ms","start":"2026-06-09T17:06:34.812222Z","end":"2026-06-09T17:06:35.157536Z","steps":["trace[393222897] 'process raft request' (duration: 344.836021ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:35.157685Z","caller":"traceutil/trace.go:171","msg":"trace[1203339744] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"346.160654ms","start":"2026-06-09T17:06:34.811512Z","end":"2026-06-09T17:06:35.157673Z","steps":["trace[1203339744] 'process raft request' (duration: 77.446969ms)","trace[1203339744] 'compare' (duration: 267.578622ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:35.157783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:34.811495Z","time spent":"346.227036ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:06:35.157578Z","caller":"traceutil/trace.go:171","msg":"trace[1065000889] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"292.073637ms","start":"2026-06-09T17:06:34.865459Z","end":"2026-06-09T17:06:35.157533Z","steps":["trace[1065000889] 'process raft request' (duration: 291.655167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:35.157875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:34.812216Z","time spent":"345.447559ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:06:35.922626Z","caller":"traceutil/trace.go:171","msg":"trace[1693125904] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"367.197957ms","start":"2026-06-09T17:06:35.555352Z","end":"2026-06-09T17:06:35.92255Z","steps":["trace[1693125904] 'process raft request' (duration: 358.918097ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:35.922846Z","caller":"traceutil/trace.go:171","msg":"trace[1038748193] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"283.970869ms","start":"2026-06-09T17:06:35.638557Z","end":"2026-06-09T17:06:35.922528Z","steps":["trace[1038748193] 'read index received' (duration: 275.2948ms)","trace[1038748193] 'applied index is now lower than readState.Index' (duration: 8.671539ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:35.922921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.347586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-09T17:06:35.922986Z","caller":"traceutil/trace.go:171","msg":"trace[1252309762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"284.446651ms","start":"2026-06-09T17:06:35.638521Z","end":"2026-06-09T17:06:35.922967Z","steps":["trace[1252309762] 'agreement among raft nodes before linearized reading' (duration: 284.271143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:35.923077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:35.555328Z","time spent":"367.47255ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:06:35.923169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.95408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-09T17:06:35.923208Z","caller":"traceutil/trace.go:171","msg":"trace[479597965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"253.061755ms","start":"2026-06-09T17:06:35.670135Z","end":"2026-06-09T17:06:35.923197Z","steps":["trace[479597965] 'agreement among raft nodes before linearized reading' (duration: 252.855694ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:52.080391Z","caller":"traceutil/trace.go:171","msg":"trace[532891060] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"452.791238ms","start":"2026-06-09T17:06:51.627573Z","end":"2026-06-09T17:06:52.080365Z","steps":["trace[532891060] 'read index received' (duration: 452.57568ms)","trace[532891060] 'applied index is now lower than readState.Index' (duration: 214.558µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:06:52.080517Z","caller":"traceutil/trace.go:171","msg":"trace[1534916164] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"626.669587ms","start":"2026-06-09T17:06:51.453837Z","end":"2026-06-09T17:06:52.080506Z","steps":["trace[1534916164] 'process raft request' (duration: 626.318854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:52.080646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:51.453813Z","time spent":"626.73304ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:06:52.08171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.081878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x54xq\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-09T17:06:52.081867Z","caller":"traceutil/trace.go:171","msg":"trace[1229223304] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x54xq; range_end:; response_count:1; response_revision:778; }","duration":"454.306677ms","start":"2026-06-09T17:06:51.627522Z","end":"2026-06-09T17:06:52.081828Z","steps":["trace[1229223304] 'agreement among raft nodes before linearized reading' (duration: 453.150502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:52.081932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:51.627496Z","time spent":"454.420361ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x54xq\" "} {"level":"warn","ts":"2026-06-09T17:06:52.08637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.376543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:06:52.086467Z","caller":"traceutil/trace.go:171","msg":"trace[1017964854] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:779; }","duration":"190.53428ms","start":"2026-06-09T17:06:51.895912Z","end":"2026-06-09T17:06:52.086446Z","steps":["trace[1017964854] 'agreement among raft nodes before linearized reading' (duration: 190.356822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:52.086429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.088178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:06:52.086636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.27208ms","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-06-09T17:06:52.086708Z","caller":"traceutil/trace.go:171","msg":"trace[77309580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"119.37391ms","start":"2026-06-09T17:06:51.967259Z","end":"2026-06-09T17:06:52.086633Z","steps":["trace[77309580] 'agreement among raft nodes before linearized reading' (duration: 119.068518ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:52.086758Z","caller":"traceutil/trace.go:171","msg":"trace[1476487568] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:779; }","duration":"158.448066ms","start":"2026-06-09T17:06:51.928271Z","end":"2026-06-09T17:06:52.086719Z","steps":["trace[1476487568] 'agreement among raft nodes before linearized reading' (duration: 158.206047ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:20.96141Z","caller":"traceutil/trace.go:171","msg":"trace[1777311255] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"137.223668ms","start":"2026-06-09T17:07:20.824162Z","end":"2026-06-09T17:07:20.961386Z","steps":["trace[1777311255] 'process raft request' (duration: 137.039642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:57.816138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.343397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:07:57.816253Z","caller":"traceutil/trace.go:171","msg":"trace[1091203130] transaction","detail":"{read_only:false; response_revision:1684; number_of_response:1; }","duration":"185.973497ms","start":"2026-06-09T17:07:57.630264Z","end":"2026-06-09T17:07:57.816237Z","steps":["trace[1091203130] 'process raft request' (duration: 185.945137ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:57.816428Z","caller":"traceutil/trace.go:171","msg":"trace[1920634897] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"186.45459ms","start":"2026-06-09T17:07:57.629966Z","end":"2026-06-09T17:07:57.816421Z","steps":["trace[1920634897] 'process raft request' (duration: 57.778775ms)","trace[1920634897] 'compare' (duration: 128.256965ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:07:57.816499Z","caller":"traceutil/trace.go:171","msg":"trace[1639598921] linearizableReadLoop","detail":"{readStateIndex:1747; appliedIndex:1746; }","duration":"186.290365ms","start":"2026-06-09T17:07:57.630204Z","end":"2026-06-09T17:07:57.816494Z","steps":["trace[1639598921] 'read index received' (duration: 57.629351ms)","trace[1639598921] 'applied index is now lower than readState.Index' (duration: 128.660494ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:07:57.816646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.435888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T17:07:57.816663Z","caller":"traceutil/trace.go:171","msg":"trace[2061334720] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1684; }","duration":"186.479639ms","start":"2026-06-09T17:07:57.630178Z","end":"2026-06-09T17:07:57.816658Z","steps":["trace[2061334720] 'agreement among raft nodes before linearized reading' (duration: 186.408537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:57.816844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.036214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T17:07:57.81686Z","caller":"traceutil/trace.go:171","msg":"trace[1671459607] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1684; }","duration":"135.057085ms","start":"2026-06-09T17:07:57.681799Z","end":"2026-06-09T17:07:57.816856Z","steps":["trace[1671459607] 'agreement among raft nodes before linearized reading' (duration: 134.925972ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:58.571427Z","caller":"traceutil/trace.go:171","msg":"trace[250607567] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"124.336292ms","start":"2026-06-09T17:07:58.447067Z","end":"2026-06-09T17:07:58.571403Z","steps":["trace[250607567] 'process raft request' (duration: 124.190379ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:58.612056Z","caller":"traceutil/trace.go:171","msg":"trace[1162147619] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"163.858179ms","start":"2026-06-09T17:07:58.448177Z","end":"2026-06-09T17:07:58.612035Z","steps":["trace[1162147619] 'process raft request' (duration: 163.765947ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:59.577031Z","caller":"traceutil/trace.go:171","msg":"trace[2069665656] linearizableReadLoop","detail":"{readStateIndex:1759; appliedIndex:1758; }","duration":"101.915938ms","start":"2026-06-09T17:07:59.475089Z","end":"2026-06-09T17:07:59.577005Z","steps":["trace[2069665656] 'read index received' (duration: 101.650623ms)","trace[2069665656] 'applied index is now lower than readState.Index' (duration: 264.455µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:07:59.577307Z","caller":"traceutil/trace.go:171","msg":"trace[1818672886] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"109.489823ms","start":"2026-06-09T17:07:59.467697Z","end":"2026-06-09T17:07:59.577187Z","steps":["trace[1818672886] 'process raft request' (duration: 109.139545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:59.577363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.265686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:2 size:136258"} {"level":"info","ts":"2026-06-09T17:07:59.577541Z","caller":"traceutil/trace.go:171","msg":"trace[260007919] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:2; response_revision:1694; }","duration":"102.445629ms","start":"2026-06-09T17:07:59.475068Z","end":"2026-06-09T17:07:59.577514Z","steps":["trace[260007919] 'agreement among raft nodes before linearized reading' (duration: 102.03533ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:59.608817Z","caller":"traceutil/trace.go:171","msg":"trace[346791636] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"100.052669ms","start":"2026-06-09T17:07:59.508724Z","end":"2026-06-09T17:07:59.608777Z","steps":["trace[346791636] 'process raft request' (duration: 99.711341ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:59.853989Z","caller":"traceutil/trace.go:171","msg":"trace[271611221] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1695; }","duration":"134.87783ms","start":"2026-06-09T17:07:59.719095Z","end":"2026-06-09T17:07:59.853973Z","steps":["trace[271611221] 'process raft request' (duration: 134.807189ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:00.161952Z","caller":"traceutil/trace.go:171","msg":"trace[840781404] linearizableReadLoop","detail":"{readStateIndex:1763; appliedIndex:1762; }","duration":"307.936141ms","start":"2026-06-09T17:07:59.853986Z","end":"2026-06-09T17:08:00.161922Z","steps":["trace[840781404] 'read index received' (duration: 307.374039ms)","trace[840781404] 'applied index is now lower than readState.Index' (duration: 561.002µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:00.162115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.512402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T17:08:00.162197Z","caller":"traceutil/trace.go:171","msg":"trace[2002941562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1695; }","duration":"313.652224ms","start":"2026-06-09T17:07:59.848529Z","end":"2026-06-09T17:08:00.162182Z","steps":["trace[2002941562] 'agreement among raft nodes before linearized reading' (duration: 313.41566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:00.162237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:59.848512Z","time spent":"313.716406ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T17:08:00.162328Z","caller":"traceutil/trace.go:171","msg":"trace[20550900] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1695; }","duration":"375.418587ms","start":"2026-06-09T17:07:59.786899Z","end":"2026-06-09T17:08:00.162318Z","steps":["trace[20550900] 'process raft request' (duration: 374.773283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:00.162417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:59.786876Z","time spent":"375.484109ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:08:00.162474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.007817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T17:08:00.16251Z","caller":"traceutil/trace.go:171","msg":"trace[1801462669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1695; }","duration":"342.088949ms","start":"2026-06-09T17:07:59.820412Z","end":"2026-06-09T17:08:00.162501Z","steps":["trace[1801462669] 'agreement among raft nodes before linearized reading' (duration: 341.986547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:00.162536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:59.820388Z","time spent":"342.14097ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T17:08:00.162546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.39331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com\" ","response":"range_response_count:1 size:9038"} {"level":"info","ts":"2026-06-09T17:08:00.162578Z","caller":"traceutil/trace.go:171","msg":"trace[782162667] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com; range_end:; response_count:1; response_revision:1695; }","duration":"307.445691ms","start":"2026-06-09T17:07:59.85512Z","end":"2026-06-09T17:08:00.162566Z","steps":["trace[782162667] 'agreement among raft nodes before linearized reading' (duration: 307.202885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:00.162614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:59.855101Z","time spent":"307.506602ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":9060,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com\" "} {"level":"warn","ts":"2026-06-09T17:08:00.162276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.750811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:08:00.162895Z","caller":"traceutil/trace.go:171","msg":"trace[2144832186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1695; }","duration":"342.468736ms","start":"2026-06-09T17:07:59.820412Z","end":"2026-06-09T17:08:00.162881Z","steps":["trace[2144832186] 'agreement among raft nodes before linearized reading' (duration: 341.663139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:00.16293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:59.820388Z","time spent":"342.532518ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:08:00.826342Z","caller":"traceutil/trace.go:171","msg":"trace[1327338128] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"204.063115ms","start":"2026-06-09T17:08:00.622251Z","end":"2026-06-09T17:08:00.826314Z","steps":["trace[1327338128] 'process raft request' (duration: 129.994547ms)","trace[1327338128] 'compare' (duration: 73.482575ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:11.441139Z","caller":"traceutil/trace.go:171","msg":"trace[1159747183] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1926; }","duration":"365.531575ms","start":"2026-06-09T17:08:11.075582Z","end":"2026-06-09T17:08:11.441113Z","steps":["trace[1159747183] 'read index received' (duration: 365.380572ms)","trace[1159747183] 'applied index is now lower than readState.Index' (duration: 149.963µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:11.441363Z","caller":"traceutil/trace.go:171","msg":"trace[634097393] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"424.690508ms","start":"2026-06-09T17:08:11.016584Z","end":"2026-06-09T17:08:11.441275Z","steps":["trace[634097393] 'process raft request' (duration: 424.374562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:11.441476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:11.016566Z","time spent":"424.83365ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:11.44147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.788849ms","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-06-09T17:08:11.441687Z","caller":"traceutil/trace.go:171","msg":"trace[1440812661] 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:1856; }","duration":"366.125766ms","start":"2026-06-09T17:08:11.07552Z","end":"2026-06-09T17:08:11.441646Z","steps":["trace[1440812661] 'agreement among raft nodes before linearized reading' (duration: 365.80703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:11.441789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:11.0755Z","time spent":"366.272269ms","remote":"127.0.0.1:48596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:08:11.633305Z","caller":"traceutil/trace.go:171","msg":"trace[927629292] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1927; }","duration":"192.069839ms","start":"2026-06-09T17:08:11.441206Z","end":"2026-06-09T17:08:11.633276Z","steps":["trace[927629292] 'read index received' (duration: 141.551489ms)","trace[927629292] 'applied index is now lower than readState.Index' (duration: 50.51716ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:11.633364Z","caller":"traceutil/trace.go:171","msg":"trace[1815540742] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"336.824191ms","start":"2026-06-09T17:08:11.296513Z","end":"2026-06-09T17:08:11.633338Z","steps":["trace[1815540742] 'process raft request' (duration: 286.178059ms)","trace[1815540742] 'compare' (duration: 50.391287ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:11.633517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:11.296484Z","time spent":"336.947264ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:11.633549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.954666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c2d815d-df99-43d2-a664-2f086f357dab\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-09T17:08:11.633587Z","caller":"traceutil/trace.go:171","msg":"trace[2130344817] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c2d815d-df99-43d2-a664-2f086f357dab; range_end:; response_count:1; response_revision:1857; }","duration":"229.052337ms","start":"2026-06-09T17:08:11.404523Z","end":"2026-06-09T17:08:11.633575Z","steps":["trace[2130344817] 'agreement among raft nodes before linearized reading' (duration: 228.884684ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:25.204858Z","caller":"traceutil/trace.go:171","msg":"trace[1767468551] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2046; }","duration":"237.52116ms","start":"2026-06-09T17:08:24.967299Z","end":"2026-06-09T17:08:25.204821Z","steps":["trace[1767468551] 'read index received' (duration: 222.091125ms)","trace[1767468551] 'applied index is now lower than readState.Index' (duration: 15.429215ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:25.204927Z","caller":"traceutil/trace.go:171","msg":"trace[318932670] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"243.141764ms","start":"2026-06-09T17:08:24.961761Z","end":"2026-06-09T17:08:25.204903Z","steps":["trace[318932670] 'process raft request' (duration: 227.562047ms)","trace[318932670] 'compare' (duration: 15.366093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:25.205003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.688763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:25.205028Z","caller":"traceutil/trace.go:171","msg":"trace[2106525713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1972; }","duration":"237.725693ms","start":"2026-06-09T17:08:24.967294Z","end":"2026-06-09T17:08:25.20502Z","steps":["trace[2106525713] 'agreement among raft nodes before linearized reading' (duration: 237.666382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:25.205285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.432999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-7fcdcd478-hqcqk\" ","response":"range_response_count:1 size:5815"} {"level":"info","ts":"2026-06-09T17:08:25.205322Z","caller":"traceutil/trace.go:171","msg":"trace[868866922] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-7fcdcd478-hqcqk; range_end:; response_count:1; response_revision:1972; }","duration":"236.521121ms","start":"2026-06-09T17:08:24.96879Z","end":"2026-06-09T17:08:25.205312Z","steps":["trace[868866922] 'agreement among raft nodes before linearized reading' (duration: 236.363477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:25.20542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.796163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-09T17:08:25.205463Z","caller":"traceutil/trace.go:171","msg":"trace[969585329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1972; }","duration":"231.875405ms","start":"2026-06-09T17:08:24.97357Z","end":"2026-06-09T17:08:25.205446Z","steps":["trace[969585329] 'agreement among raft nodes before linearized reading' (duration: 231.711082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:25.845986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.623051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:08:25.846618Z","caller":"traceutil/trace.go:171","msg":"trace[1598776138] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"636.7515ms","start":"2026-06-09T17:08:25.209838Z","end":"2026-06-09T17:08:25.846589Z","steps":["trace[1598776138] 'process raft request' (duration: 100.391944ms)","trace[1598776138] 'compare' (duration: 535.358587ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:25.846749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:25.209821Z","time spent":"636.890742ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:08:25.847284Z","caller":"traceutil/trace.go:171","msg":"trace[695283085] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"633.629991ms","start":"2026-06-09T17:08:25.213628Z","end":"2026-06-09T17:08:25.847258Z","steps":["trace[695283085] 'process raft request' (duration: 633.409928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:25.847579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:25.213599Z","time spent":"633.827926ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5586,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:08:25.855839Z","caller":"traceutil/trace.go:171","msg":"trace[480546324] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"170.291026ms","start":"2026-06-09T17:08:25.685506Z","end":"2026-06-09T17:08:25.855797Z","steps":["trace[480546324] 'process raft request' (duration: 169.751546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:45.249538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.700595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:45.249642Z","caller":"traceutil/trace.go:171","msg":"trace[1890391647] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2097; }","duration":"304.870979ms","start":"2026-06-09T17:08:44.944749Z","end":"2026-06-09T17:08:45.24962Z","steps":["trace[1890391647] 'range keys from in-memory index tree' (duration: 304.612594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:45.249693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:44.944725Z","time spent":"304.958661ms","remote":"127.0.0.1:40336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-09T17:08:45.249509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.9166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:45.249911Z","caller":"traceutil/trace.go:171","msg":"trace[2105696223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2097; }","duration":"282.344608ms","start":"2026-06-09T17:08:44.967542Z","end":"2026-06-09T17:08:45.249886Z","steps":["trace[2105696223] 'range keys from in-memory index tree' (duration: 281.787488ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:45.730532Z","caller":"traceutil/trace.go:171","msg":"trace[554388291] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2176; }","duration":"382.139933ms","start":"2026-06-09T17:08:45.348361Z","end":"2026-06-09T17:08:45.730501Z","steps":["trace[554388291] 'read index received' (duration: 381.871538ms)","trace[554388291] 'applied index is now lower than readState.Index' (duration: 267.435µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:45.730813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.438187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-09T17:08:45.730856Z","caller":"traceutil/trace.go:171","msg":"trace[1579196255] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2098; }","duration":"382.557109ms","start":"2026-06-09T17:08:45.348287Z","end":"2026-06-09T17:08:45.730844Z","steps":["trace[1579196255] 'agreement among raft nodes before linearized reading' (duration: 382.327275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:45.730894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:45.348263Z","time spent":"382.62224ms","remote":"127.0.0.1:43090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-09T17:08:45.731211Z","caller":"traceutil/trace.go:171","msg":"trace[1411007991] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"456.517533ms","start":"2026-06-09T17:08:45.274681Z","end":"2026-06-09T17:08:45.731199Z","steps":["trace[1411007991] 'process raft request' (duration: 455.660888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:45.731307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:45.274664Z","time spent":"456.585314ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:46.34526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.323288ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:46.345769Z","caller":"traceutil/trace.go:171","msg":"trace[269602926] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2101; }","duration":"278.892128ms","start":"2026-06-09T17:08:46.066848Z","end":"2026-06-09T17:08:46.34574Z","steps":["trace[269602926] 'range keys from in-memory index tree' (duration: 278.292777ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:47.08613Z","caller":"traceutil/trace.go:171","msg":"trace[67641562] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"574.667252ms","start":"2026-06-09T17:08:46.511419Z","end":"2026-06-09T17:08:47.086086Z","steps":["trace[67641562] 'process raft request' (duration: 513.542813ms)","trace[67641562] 'compare' (duration: 60.929156ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:47.086347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:46.511405Z","time spent":"574.828334ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:08:47.111227Z","caller":"traceutil/trace.go:171","msg":"trace[40984959] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"596.258093ms","start":"2026-06-09T17:08:46.514937Z","end":"2026-06-09T17:08:47.111196Z","steps":["trace[40984959] 'process raft request' (duration: 596.168771ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:47.111403Z","caller":"traceutil/trace.go:171","msg":"trace[1680858162] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2181; }","duration":"373.053116ms","start":"2026-06-09T17:08:46.738331Z","end":"2026-06-09T17:08:47.111384Z","steps":["trace[1680858162] 'read index received' (duration: 286.701407ms)","trace[1680858162] 'applied index is now lower than readState.Index' (duration: 86.350799ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:47.111633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.244919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-09T17:08:47.11216Z","caller":"traceutil/trace.go:171","msg":"trace[1691539179] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"373.838679ms","start":"2026-06-09T17:08:46.738289Z","end":"2026-06-09T17:08:47.112128Z","steps":["trace[1691539179] 'agreement among raft nodes before linearized reading' (duration: 373.168868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.112201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.989492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-09T17:08:47.112258Z","caller":"traceutil/trace.go:171","msg":"trace[1839925999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2106; }","duration":"239.094284ms","start":"2026-06-09T17:08:46.873154Z","end":"2026-06-09T17:08:47.112248Z","steps":["trace[1839925999] 'agreement among raft nodes before linearized reading' (duration: 238.995852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.112248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:46.738265Z","time spent":"373.955411ms","remote":"127.0.0.1:43090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-09T17:08:47.11232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:46.514926Z","time spent":"597.081836ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:08:47.111823Z","caller":"traceutil/trace.go:171","msg":"trace[1583768639] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"445.092852ms","start":"2026-06-09T17:08:46.66672Z","end":"2026-06-09T17:08:47.111813Z","steps":["trace[1583768639] 'process raft request' (duration: 444.433221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.11262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:46.666696Z","time spent":"445.867304ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:08:47.11255Z","caller":"traceutil/trace.go:171","msg":"trace[249360880] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"599.75474ms","start":"2026-06-09T17:08:46.511562Z","end":"2026-06-09T17:08:47.111317Z","steps":["trace[249360880] 'process raft request' (duration: 599.390604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.11302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.66929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:47.11305Z","caller":"traceutil/trace.go:171","msg":"trace[391441439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"145.745242ms","start":"2026-06-09T17:08:46.967298Z","end":"2026-06-09T17:08:47.113044Z","steps":["trace[391441439] 'agreement among raft nodes before linearized reading' (duration: 145.680201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.113065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:46.51154Z","time spent":"601.349446ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:47.585143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.939655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:08:47.58571Z","caller":"traceutil/trace.go:171","msg":"trace[637067113] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"465.205833ms","start":"2026-06-09T17:08:47.120419Z","end":"2026-06-09T17:08:47.585625Z","steps":["trace[637067113] 'read index received' (duration: 196.695398ms)","trace[637067113] 'applied index is now lower than readState.Index' (duration: 268.508165ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:47.58571Z","caller":"traceutil/trace.go:171","msg":"trace[132602606] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"466.522545ms","start":"2026-06-09T17:08:47.119136Z","end":"2026-06-09T17:08:47.585658Z","steps":["trace[132602606] 'process raft request' (duration: 197.964659ms)","trace[132602606] 'compare' (duration: 267.370937ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:08:47.58593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:47.119119Z","time spent":"466.692049ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:47.585978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.549779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:120338"} {"level":"info","ts":"2026-06-09T17:08:47.58601Z","caller":"traceutil/trace.go:171","msg":"trace[1934062951] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2107; }","duration":"465.60042ms","start":"2026-06-09T17:08:47.120398Z","end":"2026-06-09T17:08:47.585998Z","steps":["trace[1934062951] 'agreement among raft nodes before linearized reading' (duration: 465.410647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:47.586043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:47.12039Z","time spent":"465.6457ms","remote":"127.0.0.1:39914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":120360,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-09T17:08:47.586011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.893522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:08:47.586117Z","caller":"traceutil/trace.go:171","msg":"trace[1604505171] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2107; }","duration":"158.063464ms","start":"2026-06-09T17:08:47.428033Z","end":"2026-06-09T17:08:47.586097Z","steps":["trace[1604505171] 'agreement among raft nodes before linearized reading' (duration: 157.890322ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:08:47.985635Z","caller":"traceutil/trace.go:171","msg":"trace[1522254233] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"247.23131ms","start":"2026-06-09T17:08:47.73837Z","end":"2026-06-09T17:08:47.985602Z","steps":["trace[1522254233] 'process raft request' (duration: 245.901048ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:09:20.42268Z","caller":"traceutil/trace.go:171","msg":"trace[236581004] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"190.910625ms","start":"2026-06-09T17:09:20.231735Z","end":"2026-06-09T17:09:20.422645Z","steps":["trace[236581004] 'process raft request' (duration: 188.035731ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:09:51.128875Z","caller":"traceutil/trace.go:171","msg":"trace[1203440744] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"247.652397ms","start":"2026-06-09T17:09:50.881194Z","end":"2026-06-09T17:09:51.128847Z","steps":["trace[1203440744] 'process raft request' (duration: 247.424164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:09:51.973438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.633482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-09T17:09:51.973468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.660252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:09:51.973524Z","caller":"traceutil/trace.go:171","msg":"trace[1353286469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2554; }","duration":"510.755583ms","start":"2026-06-09T17:09:51.462753Z","end":"2026-06-09T17:09:51.973509Z","steps":["trace[1353286469] 'range keys from in-memory index tree' (duration: 510.486049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:09:51.973561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:09:51.462737Z","time spent":"510.815604ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:09:51.973561Z","caller":"traceutil/trace.go:171","msg":"trace[599204049] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2554; }","duration":"226.793414ms","start":"2026-06-09T17:09:51.746745Z","end":"2026-06-09T17:09:51.973539Z","steps":["trace[599204049] 'count revisions from in-memory index tree' (duration: 226.587632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:09:51.973622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.074556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T17:09:51.973678Z","caller":"traceutil/trace.go:171","msg":"trace[347108585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2554; }","duration":"508.154667ms","start":"2026-06-09T17:09:51.465508Z","end":"2026-06-09T17:09:51.973662Z","steps":["trace[347108585] 'range keys from in-memory index tree' (duration: 507.983474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:09:51.973706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:09:51.465499Z","time spent":"508.199487ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T17:10:18.249012Z","caller":"traceutil/trace.go:171","msg":"trace[597467642] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"113.281532ms","start":"2026-06-09T17:10:18.135701Z","end":"2026-06-09T17:10:18.248983Z","steps":["trace[597467642] 'process raft request' (duration: 112.988198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:10:23.771179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.357288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T17:10:23.771303Z","caller":"traceutil/trace.go:171","msg":"trace[547972212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2730; }","duration":"233.51115ms","start":"2026-06-09T17:10:23.537759Z","end":"2026-06-09T17:10:23.77127Z","steps":["trace[547972212] 'range keys from in-memory index tree' (duration: 232.921642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:10:24.220477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.57206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:10:24.220563Z","caller":"traceutil/trace.go:171","msg":"trace[89830173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2731; }","duration":"255.703022ms","start":"2026-06-09T17:10:23.964841Z","end":"2026-06-09T17:10:24.220545Z","steps":["trace[89830173] 'range keys from in-memory index tree' (duration: 255.390828ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:12.154559Z","caller":"traceutil/trace.go:171","msg":"trace[153985672] transaction","detail":"{read_only:false; response_revision:2984; number_of_response:1; }","duration":"599.744294ms","start":"2026-06-09T17:11:11.554795Z","end":"2026-06-09T17:11:12.15454Z","steps":["trace[153985672] 'process raft request' (duration: 599.613679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:12.154704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:11.55478Z","time spent":"599.862808ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:11:12.155503Z","caller":"traceutil/trace.go:171","msg":"trace[1085453694] transaction","detail":"{read_only:false; response_revision:2985; number_of_response:1; }","duration":"520.029272ms","start":"2026-06-09T17:11:11.635458Z","end":"2026-06-09T17:11:12.155488Z","steps":["trace[1085453694] 'process raft request' (duration: 519.618886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:12.155584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:11.635433Z","time spent":"520.114455ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:13.085077Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280262147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:11:13.585835Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280262147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:11:14.086248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280262147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:11:14.586355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280262147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:11:15.005459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.038323275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-09T17:11:15.005588Z","caller":"traceutil/trace.go:171","msg":"trace[398181765] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.038523793s","start":"2026-06-09T17:11:12.967036Z","end":"2026-06-09T17:11:15.00556Z","steps":["trace[398181765] 'agreement among raft nodes before linearized reading' (duration: 2.038361247s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.005657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.967015Z","time spent":"2.038632407s","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:11:15.087682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280262147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:11:15.298642Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.725159628s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T17:11:15.299539Z","caller":"traceutil/trace.go:171","msg":"trace[691616673] transaction","detail":"{read_only:false; response_revision:2987; number_of_response:1; }","duration":"2.726138165s","start":"2026-06-09T17:11:12.573377Z","end":"2026-06-09T17:11:15.299515Z","steps":["trace[691616673] 'process raft request' (duration: 2.725937648s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.299657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.573352Z","time spent":"2.726229798s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:11:15.334848Z","caller":"traceutil/trace.go:171","msg":"trace[1307553786] transaction","detail":"{read_only:false; response_revision:2988; number_of_response:1; }","duration":"2.729268185s","start":"2026-06-09T17:11:12.605555Z","end":"2026-06-09T17:11:15.334823Z","steps":["trace[1307553786] 'process raft request' (duration: 2.729078948s)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:15.334906Z","caller":"traceutil/trace.go:171","msg":"trace[945155468] transaction","detail":"{read_only:false; response_revision:2989; number_of_response:1; }","duration":"2.726812331s","start":"2026-06-09T17:11:12.60807Z","end":"2026-06-09T17:11:15.334883Z","steps":["trace[945155468] 'process raft request' (duration: 2.726670476s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.335033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.608062Z","time spent":"2.726901305s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:15.335302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.605537Z","time spent":"2.729375019s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:11:15.339884Z","caller":"traceutil/trace.go:171","msg":"trace[453819827] linearizableReadLoop","detail":"{readStateIndex:3104; appliedIndex:3098; }","duration":"2.754870008s","start":"2026-06-09T17:11:12.584996Z","end":"2026-06-09T17:11:15.339866Z","steps":["trace[453819827] 'read index received' (duration: 2.714332485s)","trace[453819827] 'applied index is now lower than readState.Index' (duration: 40.536663ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:15.339884Z","caller":"traceutil/trace.go:171","msg":"trace[867598300] transaction","detail":"{read_only:false; response_revision:2990; number_of_response:1; }","duration":"467.036451ms","start":"2026-06-09T17:11:14.872832Z","end":"2026-06-09T17:11:15.339868Z","steps":["trace[867598300] 'process raft request' (duration: 466.843964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.755039044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T17:11:15.340073Z","caller":"traceutil/trace.go:171","msg":"trace[173503188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2991; }","duration":"2.755121569s","start":"2026-06-09T17:11:12.584945Z","end":"2026-06-09T17:11:15.340067Z","steps":["trace[173503188] 'agreement among raft nodes before linearized reading' (duration: 2.755008455s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.872802Z","time spent":"467.227188ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:15.340161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.584909Z","time spent":"2.755247393s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T17:11:15.339936Z","caller":"traceutil/trace.go:171","msg":"trace[1791760737] transaction","detail":"{read_only:false; response_revision:2991; number_of_response:1; }","duration":"466.951377ms","start":"2026-06-09T17:11:14.872979Z","end":"2026-06-09T17:11:15.33993Z","steps":["trace[1791760737] 'process raft request' (duration: 466.838492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.872972Z","time spent":"467.249488ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:15.340325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.023823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b778ce2a09c0d1\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-06-09T17:11:15.340344Z","caller":"traceutil/trace.go:171","msg":"trace[1377998684] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b778ce2a09c0d1; range_end:; response_count:1; response_revision:2991; }","duration":"550.073286ms","start":"2026-06-09T17:11:14.790265Z","end":"2026-06-09T17:11:15.340338Z","steps":["trace[1377998684] 'agreement among raft nodes before linearized reading' (duration: 550.018444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.341829408s","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-06-09T17:11:15.340451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.755255452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T17:11:15.340549Z","caller":"traceutil/trace.go:171","msg":"trace[1184866923] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2991; }","duration":"2.341900721s","start":"2026-06-09T17:11:12.998642Z","end":"2026-06-09T17:11:15.340543Z","steps":["trace[1184866923] 'agreement among raft nodes before linearized reading' (duration: 2.341826998s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.998621Z","time spent":"2.341940512s","remote":"127.0.0.1:40124","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-06-09T17:11:15.340624Z","caller":"traceutil/trace.go:171","msg":"trace[1146903711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2991; }","duration":"2.755447091s","start":"2026-06-09T17:11:12.585165Z","end":"2026-06-09T17:11:15.340612Z","steps":["trace[1146903711] 'agreement among raft nodes before linearized reading' (duration: 2.755091437s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.585156Z","time spent":"2.755563984s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T17:11:15.340772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.415798877s","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-06-09T17:11:15.340795Z","caller":"traceutil/trace.go:171","msg":"trace[190318149] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2991; }","duration":"2.41585921s","start":"2026-06-09T17:11:12.924929Z","end":"2026-06-09T17:11:15.340789Z","steps":["trace[190318149] 'agreement among raft nodes before linearized reading' (duration: 2.415810938s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.340814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.924907Z","time spent":"2.415902411s","remote":"127.0.0.1:57396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":19,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.341049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.459394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:11:15.341102Z","caller":"traceutil/trace.go:171","msg":"trace[691123369] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2991; }","duration":"628.551209ms","start":"2026-06-09T17:11:14.712544Z","end":"2026-06-09T17:11:15.341096Z","steps":["trace[691123369] 'agreement among raft nodes before linearized reading' (duration: 628.441955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.34112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.712523Z","time spent":"628.59144ms","remote":"127.0.0.1:48566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.341333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.655242ms","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-06-09T17:11:15.341357Z","caller":"traceutil/trace.go:171","msg":"trace[2015939161] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2991; }","duration":"628.690453ms","start":"2026-06-09T17:11:14.71266Z","end":"2026-06-09T17:11:15.341351Z","steps":["trace[2015939161] 'agreement among raft nodes before linearized reading' (duration: 628.654762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.341375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.712655Z","time spent":"628.714724ms","remote":"127.0.0.1:43090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.341412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.618432028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-09T17:11:15.341496Z","caller":"traceutil/trace.go:171","msg":"trace[26337889] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2991; }","duration":"2.618524841s","start":"2026-06-09T17:11:12.722939Z","end":"2026-06-09T17:11:15.341464Z","steps":["trace[26337889] 'agreement among raft nodes before linearized reading' (duration: 2.618370536s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.341537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:12.722925Z","time spent":"2.618601155s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-09T17:11:15.340661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.312003766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-09T17:11:15.341656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.15176ms","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-06-09T17:11:15.341675Z","caller":"traceutil/trace.go:171","msg":"trace[1325089380] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2991; }","duration":"469.191192ms","start":"2026-06-09T17:11:14.872478Z","end":"2026-06-09T17:11:15.341669Z","steps":["trace[1325089380] 'agreement among raft nodes before linearized reading' (duration: 469.13705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.34168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.283191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:11:15.341755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.321852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:11:15.341691Z","caller":"traceutil/trace.go:171","msg":"trace[657774087] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2991; }","duration":"2.313053915s","start":"2026-06-09T17:11:13.028604Z","end":"2026-06-09T17:11:15.341658Z","steps":["trace[657774087] 'agreement among raft nodes before linearized reading' (duration: 2.312036718s)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:15.341765Z","caller":"traceutil/trace.go:171","msg":"trace[856115149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:2991; }","duration":"551.382794ms","start":"2026-06-09T17:11:14.790369Z","end":"2026-06-09T17:11:15.341752Z","steps":["trace[856115149] 'agreement among raft nodes before linearized reading' (duration: 551.26998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.341792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:13.02858Z","time spent":"2.313198351s","remote":"127.0.0.1:48612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.341852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.230622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-09T17:11:15.341877Z","caller":"traceutil/trace.go:171","msg":"trace[2018256259] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2991; }","duration":"469.266664ms","start":"2026-06-09T17:11:14.872602Z","end":"2026-06-09T17:11:15.341869Z","steps":["trace[2018256259] 'agreement among raft nodes before linearized reading' (duration: 469.210752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.341899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.872596Z","time spent":"469.296235ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-09T17:11:15.341914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.647807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T17:11:15.34196Z","caller":"traceutil/trace.go:171","msg":"trace[1822741471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2991; }","duration":"469.68198ms","start":"2026-06-09T17:11:14.872257Z","end":"2026-06-09T17:11:15.341939Z","steps":["trace[1822741471] 'agreement among raft nodes before linearized reading' (duration: 469.566325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.341993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.872167Z","time spent":"469.818286ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T17:11:15.341774Z","caller":"traceutil/trace.go:171","msg":"trace[31401417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2991; }","duration":"328.366793ms","start":"2026-06-09T17:11:15.013402Z","end":"2026-06-09T17:11:15.341769Z","steps":["trace[31401417] 'agreement among raft nodes before linearized reading' (duration: 328.340232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.342041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:15.013388Z","time spent":"328.648035ms","remote":"127.0.0.1:39860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:11:15.341698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.872471Z","time spent":"469.220083ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-09T17:11:15.341804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.790363Z","time spent":"551.428476ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.34211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.715117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-09T17:11:15.342186Z","caller":"traceutil/trace.go:171","msg":"trace[1084956368] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2991; }","duration":"551.813681ms","start":"2026-06-09T17:11:14.790355Z","end":"2026-06-09T17:11:15.342168Z","steps":["trace[1084956368] 'agreement among raft nodes before linearized reading' (duration: 551.603222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.342232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.790348Z","time spent":"551.874633ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-09T17:11:15.342396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.811656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:11:15.342438Z","caller":"traceutil/trace.go:171","msg":"trace[31602917] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2991; }","duration":"629.884809ms","start":"2026-06-09T17:11:14.712543Z","end":"2026-06-09T17:11:15.342428Z","steps":["trace[31602917] 'agreement among raft nodes before linearized reading' (duration: 629.820317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.342472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.712527Z","time spent":"629.93618ms","remote":"127.0.0.1:36118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.341801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.414069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:11:15.342638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.255057ms","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-06-09T17:11:15.342736Z","caller":"traceutil/trace.go:171","msg":"trace[1061579628] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2991; }","duration":"552.401693ms","start":"2026-06-09T17:11:14.790319Z","end":"2026-06-09T17:11:15.342721Z","steps":["trace[1061579628] 'agreement among raft nodes before linearized reading' (duration: 552.242516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.342776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.790294Z","time spent":"552.473575ms","remote":"127.0.0.1:40226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.342545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.127155092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-09T17:11:15.342868Z","caller":"traceutil/trace.go:171","msg":"trace[1216013218] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2991; }","duration":"2.127509017s","start":"2026-06-09T17:11:13.215347Z","end":"2026-06-09T17:11:15.342856Z","steps":["trace[1216013218] 'agreement among raft nodes before linearized reading' (duration: 2.127145113s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.34291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:13.21533Z","time spent":"2.127568978s","remote":"127.0.0.1:40044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-09T17:11:15.342832Z","caller":"traceutil/trace.go:171","msg":"trace[1270079391] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2991; }","duration":"336.348904ms","start":"2026-06-09T17:11:15.006358Z","end":"2026-06-09T17:11:15.342707Z","steps":["trace[1270079391] 'agreement among raft nodes before linearized reading' (duration: 335.426099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.343046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:15.006342Z","time spent":"336.690307ms","remote":"127.0.0.1:40108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.342576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.189071452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:11:15.343189Z","caller":"traceutil/trace.go:171","msg":"trace[1519554849] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2991; }","duration":"2.190979313s","start":"2026-06-09T17:11:13.152195Z","end":"2026-06-09T17:11:15.343174Z","steps":["trace[1519554849] 'agreement among raft nodes before linearized reading' (duration: 2.188204309s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:15.343246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:13.152168Z","time spent":"2.191060326s","remote":"127.0.0.1:40288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:11:15.342606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:14.790245Z","time spent":"550.110547ms","remote":"127.0.0.1:39928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":801,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b778ce2a09c0d1\" "} {"level":"info","ts":"2026-06-09T17:11:20.399234Z","caller":"traceutil/trace.go:171","msg":"trace[715048971] transaction","detail":"{read_only:false; response_revision:3017; number_of_response:1; }","duration":"102.30557ms","start":"2026-06-09T17:11:20.296901Z","end":"2026-06-09T17:11:20.399207Z","steps":["trace[715048971] 'process raft request' (duration: 93.297569ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:20.399511Z","caller":"traceutil/trace.go:171","msg":"trace[363882810] transaction","detail":"{read_only:false; response_revision:3019; number_of_response:1; }","duration":"102.173665ms","start":"2026-06-09T17:11:20.297314Z","end":"2026-06-09T17:11:20.399488Z","steps":["trace[363882810] 'process raft request' (duration: 101.965878ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:20.399557Z","caller":"traceutil/trace.go:171","msg":"trace[1806332198] transaction","detail":"{read_only:false; response_revision:3018; number_of_response:1; }","duration":"102.583501ms","start":"2026-06-09T17:11:20.29696Z","end":"2026-06-09T17:11:20.399543Z","steps":["trace[1806332198] 'process raft request' (duration: 102.201807ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:20.399759Z","caller":"traceutil/trace.go:171","msg":"trace[1605180673] transaction","detail":"{read_only:false; response_revision:3020; number_of_response:1; }","duration":"102.184556ms","start":"2026-06-09T17:11:20.297536Z","end":"2026-06-09T17:11:20.399721Z","steps":["trace[1605180673] 'process raft request' (duration: 101.902095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:20.399828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.855231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-09T17:11:20.401318Z","caller":"traceutil/trace.go:171","msg":"trace[853226048] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3021; }","duration":"107.352546ms","start":"2026-06-09T17:11:20.293944Z","end":"2026-06-09T17:11:20.401296Z","steps":["trace[853226048] 'agreement among raft nodes before linearized reading' (duration: 105.796229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:20.399886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.567487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-06-09T17:11:20.401464Z","caller":"traceutil/trace.go:171","msg":"trace[1326371507] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:3021; }","duration":"105.156725ms","start":"2026-06-09T17:11:20.296298Z","end":"2026-06-09T17:11:20.401455Z","steps":["trace[1326371507] 'agreement among raft nodes before linearized reading' (duration: 103.545336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:51.079954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.600387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:11:51.080195Z","caller":"traceutil/trace.go:171","msg":"trace[259062047] transaction","detail":"{read_only:false; response_revision:3179; number_of_response:1; }","duration":"308.270473ms","start":"2026-06-09T17:11:50.771908Z","end":"2026-06-09T17:11:51.080178Z","steps":["trace[259062047] 'process raft request' (duration: 308.1568ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:51.080235Z","caller":"traceutil/trace.go:171","msg":"trace[2001738205] linearizableReadLoop","detail":"{readStateIndex:3299; appliedIndex:3297; }","duration":"108.846775ms","start":"2026-06-09T17:11:50.971364Z","end":"2026-06-09T17:11:51.080211Z","steps":["trace[2001738205] 'read index received' (duration: 39.040743ms)","trace[2001738205] 'applied index is now lower than readState.Index' (duration: 69.803732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:51.0803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:50.77187Z","time spent":"308.372606ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:11:51.080333Z","caller":"traceutil/trace.go:171","msg":"trace[726355161] transaction","detail":"{read_only:false; response_revision:3178; number_of_response:1; }","duration":"311.257409ms","start":"2026-06-09T17:11:50.768886Z","end":"2026-06-09T17:11:51.080143Z","steps":["trace[726355161] 'process raft request' (duration: 202.393313ms)","trace[726355161] 'compare' (duration: 108.36462ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:51.080364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:50.768875Z","time spent":"311.473787ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:51.08053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.150285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-09T17:11:51.080602Z","caller":"traceutil/trace.go:171","msg":"trace[1611847009] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3179; }","duration":"109.254388ms","start":"2026-06-09T17:11:50.97133Z","end":"2026-06-09T17:11:51.080584Z","steps":["trace[1611847009] 'agreement among raft nodes before linearized reading' (duration: 109.031401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:52.765008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.376377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:11:52.765128Z","caller":"traceutil/trace.go:171","msg":"trace[392139102] linearizableReadLoop","detail":"{readStateIndex:3302; appliedIndex:3300; }","duration":"154.198473ms","start":"2026-06-09T17:11:52.610918Z","end":"2026-06-09T17:11:52.765116Z","steps":["trace[392139102] 'read index received' (duration: 33.724283ms)","trace[392139102] 'applied index is now lower than readState.Index' (duration: 120.47352ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:52.765303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.38257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-09T17:11:52.76533Z","caller":"traceutil/trace.go:171","msg":"trace[1827087609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3182; }","duration":"154.438362ms","start":"2026-06-09T17:11:52.610884Z","end":"2026-06-09T17:11:52.765323Z","steps":["trace[1827087609] 'agreement among raft nodes before linearized reading' (duration: 154.263386ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:52.765472Z","caller":"traceutil/trace.go:171","msg":"trace[308639433] transaction","detail":"{read_only:false; response_revision:3181; number_of_response:1; }","duration":"163.879575ms","start":"2026-06-09T17:11:52.601582Z","end":"2026-06-09T17:11:52.765462Z","steps":["trace[308639433] 'process raft request' (duration: 42.984161ms)","trace[308639433] 'compare' (duration: 120.246883ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:52.76557Z","caller":"traceutil/trace.go:171","msg":"trace[1695549865] transaction","detail":"{read_only:false; response_revision:3182; number_of_response:1; }","duration":"163.049669ms","start":"2026-06-09T17:11:52.602497Z","end":"2026-06-09T17:11:52.765547Z","steps":["trace[1695549865] 'process raft request' (duration: 162.587893ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:52.939675Z","caller":"traceutil/trace.go:171","msg":"trace[1246292439] linearizableReadLoop","detail":"{readStateIndex:3303; appliedIndex:3302; }","duration":"169.186366ms","start":"2026-06-09T17:11:52.770462Z","end":"2026-06-09T17:11:52.939649Z","steps":["trace[1246292439] 'read index received' (duration: 117.627639ms)","trace[1246292439] 'applied index is now lower than readState.Index' (duration: 51.557737ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:52.939807Z","caller":"traceutil/trace.go:171","msg":"trace[1305719847] transaction","detail":"{read_only:false; response_revision:3183; number_of_response:1; }","duration":"169.34586ms","start":"2026-06-09T17:11:52.770424Z","end":"2026-06-09T17:11:52.93977Z","steps":["trace[1305719847] 'process raft request' (duration: 117.633759ms)","trace[1305719847] 'compare' (duration: 51.470284ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:52.939937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.722758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:11:52.939987Z","caller":"traceutil/trace.go:171","msg":"trace[1396226352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3183; }","duration":"167.80427ms","start":"2026-06-09T17:11:52.772173Z","end":"2026-06-09T17:11:52.939977Z","steps":["trace[1396226352] 'agreement among raft nodes before linearized reading' (duration: 167.623434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:52.940083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.767969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T17:11:52.940186Z","caller":"traceutil/trace.go:171","msg":"trace[1801280144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3183; }","duration":"167.941764ms","start":"2026-06-09T17:11:52.772221Z","end":"2026-06-09T17:11:52.940163Z","steps":["trace[1801280144] 'agreement among raft nodes before linearized reading' (duration: 167.631205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:52.940506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.022302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T17:11:52.940563Z","caller":"traceutil/trace.go:171","msg":"trace[1144537438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3183; }","duration":"170.143035ms","start":"2026-06-09T17:11:52.770408Z","end":"2026-06-09T17:11:52.940551Z","steps":["trace[1144537438] 'agreement among raft nodes before linearized reading' (duration: 169.946419ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:53.110494Z","caller":"traceutil/trace.go:171","msg":"trace[2019386104] transaction","detail":"{read_only:false; response_revision:3184; number_of_response:1; }","duration":"166.452264ms","start":"2026-06-09T17:11:52.944009Z","end":"2026-06-09T17:11:53.110461Z","steps":["trace[2019386104] 'process raft request' (duration: 157.57628ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:53.110795Z","caller":"traceutil/trace.go:171","msg":"trace[1545155673] transaction","detail":"{read_only:false; response_revision:3185; number_of_response:1; }","duration":"165.512993ms","start":"2026-06-09T17:11:52.945248Z","end":"2026-06-09T17:11:53.11076Z","steps":["trace[1545155673] 'process raft request' (duration: 165.170812ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:53.111104Z","caller":"traceutil/trace.go:171","msg":"trace[1544433113] transaction","detail":"{read_only:false; response_revision:3186; number_of_response:1; }","duration":"165.086389ms","start":"2026-06-09T17:11:52.945996Z","end":"2026-06-09T17:11:53.111083Z","steps":["trace[1544433113] 'process raft request' (duration: 164.646755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:53.111303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.510839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:11:53.111362Z","caller":"traceutil/trace.go:171","msg":"trace[976148853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3186; }","duration":"144.619062ms","start":"2026-06-09T17:11:52.966729Z","end":"2026-06-09T17:11:53.111349Z","steps":["trace[976148853] 'agreement among raft nodes before linearized reading' (duration: 144.481448ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:53.110992Z","caller":"traceutil/trace.go:171","msg":"trace[825221341] linearizableReadLoop","detail":"{readStateIndex:3306; appliedIndex:3303; }","duration":"144.198528ms","start":"2026-06-09T17:11:52.966772Z","end":"2026-06-09T17:11:53.11097Z","steps":["trace[825221341] 'read index received' (duration: 134.691144ms)","trace[825221341] 'applied index is now lower than readState.Index' (duration: 9.506384ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:54.780469Z","caller":"traceutil/trace.go:171","msg":"trace[874618208] transaction","detail":"{read_only:false; response_revision:3189; number_of_response:1; }","duration":"278.086972ms","start":"2026-06-09T17:11:54.502364Z","end":"2026-06-09T17:11:54.780451Z","steps":["trace[874618208] 'process raft request' (duration: 277.972579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:55.185946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.59879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:11:55.186191Z","caller":"traceutil/trace.go:171","msg":"trace[1656292085] transaction","detail":"{read_only:false; response_revision:3190; number_of_response:1; }","duration":"415.617684ms","start":"2026-06-09T17:11:54.770537Z","end":"2026-06-09T17:11:55.186155Z","steps":["trace[1656292085] 'process raft request' (duration: 113.683172ms)","trace[1656292085] 'compare' (duration: 301.478227ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:55.186252Z","caller":"traceutil/trace.go:171","msg":"trace[209220449] linearizableReadLoop","detail":"{readStateIndex:3312; appliedIndex:3310; }","duration":"241.548266ms","start":"2026-06-09T17:11:54.944685Z","end":"2026-06-09T17:11:55.186233Z","steps":["trace[209220449] 'read index received' (duration: 34.891µs)","trace[209220449] 'applied index is now lower than readState.Index' (duration: 241.512475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:55.186327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:54.770521Z","time spent":"415.730728ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:55.18654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.675081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:11:55.186613Z","caller":"traceutil/trace.go:171","msg":"trace[699019840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3191; }","duration":"220.780444ms","start":"2026-06-09T17:11:54.965814Z","end":"2026-06-09T17:11:55.186595Z","steps":["trace[699019840] 'agreement among raft nodes before linearized reading' (duration: 220.672751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:55.186716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.03502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-09T17:11:55.186788Z","caller":"traceutil/trace.go:171","msg":"trace[232411070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3191; }","duration":"242.106123ms","start":"2026-06-09T17:11:54.944638Z","end":"2026-06-09T17:11:55.186744Z","steps":["trace[232411070] 'agreement among raft nodes before linearized reading' (duration: 242.001489ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:55.186449Z","caller":"traceutil/trace.go:171","msg":"trace[618535649] transaction","detail":"{read_only:false; response_revision:3191; number_of_response:1; }","duration":"415.211441ms","start":"2026-06-09T17:11:54.77122Z","end":"2026-06-09T17:11:55.186432Z","steps":["trace[618535649] 'process raft request' (duration: 414.827708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:55.187276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:54.771214Z","time spent":"415.852471ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:12:15.073279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.48153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:12:15.073361Z","caller":"traceutil/trace.go:171","msg":"trace[1569232650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3290; }","duration":"107.618274ms","start":"2026-06-09T17:12:14.965722Z","end":"2026-06-09T17:12:15.073341Z","steps":["trace[1569232650] 'range keys from in-memory index tree' (duration: 107.301345ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:49.689694Z","caller":"traceutil/trace.go:171","msg":"trace[1994967693] linearizableReadLoop","detail":"{readStateIndex:3703; appliedIndex:3702; }","duration":"119.075859ms","start":"2026-06-09T17:12:49.570598Z","end":"2026-06-09T17:12:49.689674Z","steps":["trace[1994967693] 'read index received' (duration: 33.546672ms)","trace[1994967693] 'applied index is now lower than readState.Index' (duration: 85.528237ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:49.689858Z","caller":"traceutil/trace.go:171","msg":"trace[1558443604] transaction","detail":"{read_only:false; response_revision:3567; number_of_response:1; }","duration":"120.070644ms","start":"2026-06-09T17:12:49.569777Z","end":"2026-06-09T17:12:49.689848Z","steps":["trace[1558443604] 'process raft request' (duration: 34.173158ms)","trace[1558443604] 'compare' (duration: 85.613809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:49.690047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.432538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T17:12:49.690168Z","caller":"traceutil/trace.go:171","msg":"trace[366641999] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3567; }","duration":"119.581462ms","start":"2026-06-09T17:12:49.57058Z","end":"2026-06-09T17:12:49.690161Z","steps":["trace[366641999] 'agreement among raft nodes before linearized reading' (duration: 119.388306ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:49.720163Z","caller":"traceutil/trace.go:171","msg":"trace[1422656641] transaction","detail":"{read_only:false; response_revision:3568; number_of_response:1; }","duration":"149.323713ms","start":"2026-06-09T17:12:49.57082Z","end":"2026-06-09T17:12:49.720144Z","steps":["trace[1422656641] 'process raft request' (duration: 149.080746ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:49.720163Z","caller":"traceutil/trace.go:171","msg":"trace[1656665705] transaction","detail":"{read_only:false; response_revision:3569; number_of_response:1; }","duration":"148.969074ms","start":"2026-06-09T17:12:49.57115Z","end":"2026-06-09T17:12:49.720119Z","steps":["trace[1656665705] 'process raft request' (duration: 148.904241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:49.731754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.67674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:12:49.731792Z","caller":"traceutil/trace.go:171","msg":"trace[50314588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3571; }","duration":"158.737971ms","start":"2026-06-09T17:12:49.573045Z","end":"2026-06-09T17:12:49.731783Z","steps":["trace[50314588] 'agreement among raft nodes before linearized reading' (duration: 158.394602ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.694788Z","caller":"traceutil/trace.go:171","msg":"trace[1867838294] transaction","detail":"{read_only:false; response_revision:4383; number_of_response:1; }","duration":"117.277512ms","start":"2026-06-09T17:14:26.577486Z","end":"2026-06-09T17:14:26.694764Z","steps":["trace[1867838294] 'process raft request' (duration: 117.19295ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.694801Z","caller":"traceutil/trace.go:171","msg":"trace[1178759953] transaction","detail":"{read_only:false; response_revision:4382; number_of_response:1; }","duration":"118.942655ms","start":"2026-06-09T17:14:26.575809Z","end":"2026-06-09T17:14:26.694752Z","steps":["trace[1178759953] 'process raft request' (duration: 68.065041ms)","trace[1178759953] 'compare' (duration: 50.67206ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:26.817891Z","caller":"traceutil/trace.go:171","msg":"trace[475281526] transaction","detail":"{read_only:false; response_revision:4388; number_of_response:1; }","duration":"100.556645ms","start":"2026-06-09T17:14:26.717303Z","end":"2026-06-09T17:14:26.81786Z","steps":["trace[475281526] 'process raft request' (duration: 97.568703ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.817972Z","caller":"traceutil/trace.go:171","msg":"trace[1390299021] transaction","detail":"{read_only:false; response_revision:4389; number_of_response:1; }","duration":"100.469623ms","start":"2026-06-09T17:14:26.717461Z","end":"2026-06-09T17:14:26.817931Z","steps":["trace[1390299021] 'process raft request' (duration: 100.190388ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.81821Z","caller":"traceutil/trace.go:171","msg":"trace[612897747] transaction","detail":"{read_only:false; response_revision:4392; number_of_response:1; }","duration":"100.498095ms","start":"2026-06-09T17:14:26.717664Z","end":"2026-06-09T17:14:26.818162Z","steps":["trace[612897747] 'process raft request' (duration: 100.226508ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.818233Z","caller":"traceutil/trace.go:171","msg":"trace[1661687818] transaction","detail":"{read_only:false; response_revision:4390; number_of_response:1; }","duration":"100.592406ms","start":"2026-06-09T17:14:26.717608Z","end":"2026-06-09T17:14:26.8182Z","steps":["trace[1661687818] 'process raft request' (duration: 100.176297ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.818275Z","caller":"traceutil/trace.go:171","msg":"trace[146363233] transaction","detail":"{read_only:false; response_revision:4393; number_of_response:1; }","duration":"100.538116ms","start":"2026-06-09T17:14:26.717686Z","end":"2026-06-09T17:14:26.818224Z","steps":["trace[146363233] 'process raft request' (duration: 100.25991ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.818358Z","caller":"traceutil/trace.go:171","msg":"trace[579434111] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"100.567157ms","start":"2026-06-09T17:14:26.717639Z","end":"2026-06-09T17:14:26.818206Z","steps":["trace[579434111] 'process raft request' (duration: 100.183868ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.818377Z","caller":"traceutil/trace.go:171","msg":"trace[1664377989] transaction","detail":"{read_only:false; response_revision:4394; number_of_response:1; }","duration":"100.574656ms","start":"2026-06-09T17:14:26.717716Z","end":"2026-06-09T17:14:26.818291Z","steps":["trace[1664377989] 'process raft request' (duration: 100.271139ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.818461Z","caller":"traceutil/trace.go:171","msg":"trace[881655616] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"100.713479ms","start":"2026-06-09T17:14:26.71774Z","end":"2026-06-09T17:14:26.818454Z","steps":["trace[881655616] 'process raft request' (duration: 100.446624ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.822681Z","caller":"traceutil/trace.go:171","msg":"trace[1689003722] transaction","detail":"{read_only:false; response_revision:4396; number_of_response:1; }","duration":"103.945236ms","start":"2026-06-09T17:14:26.717764Z","end":"2026-06-09T17:14:26.82171Z","steps":["trace[1689003722] 'process raft request' (duration: 102.628399ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.824558Z","caller":"traceutil/trace.go:171","msg":"trace[1152646601] transaction","detail":"{read_only:false; response_revision:4397; number_of_response:1; }","duration":"106.756075ms","start":"2026-06-09T17:14:26.717787Z","end":"2026-06-09T17:14:26.824543Z","steps":["trace[1152646601] 'process raft request' (duration: 102.68333ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.824728Z","caller":"traceutil/trace.go:171","msg":"trace[1397011847] transaction","detail":"{read_only:false; response_revision:4398; number_of_response:1; }","duration":"104.512198ms","start":"2026-06-09T17:14:26.720173Z","end":"2026-06-09T17:14:26.824685Z","steps":["trace[1397011847] 'process raft request' (duration: 104.079798ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.82481Z","caller":"traceutil/trace.go:171","msg":"trace[1665175453] transaction","detail":"{read_only:false; response_revision:4399; number_of_response:1; }","duration":"104.580839ms","start":"2026-06-09T17:14:26.720217Z","end":"2026-06-09T17:14:26.824798Z","steps":["trace[1665175453] 'process raft request' (duration: 104.364645ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.824977Z","caller":"traceutil/trace.go:171","msg":"trace[682944262] transaction","detail":"{read_only:false; response_revision:4400; number_of_response:1; }","duration":"104.548318ms","start":"2026-06-09T17:14:26.720276Z","end":"2026-06-09T17:14:26.824824Z","steps":["trace[682944262] 'process raft request' (duration: 104.336844ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.825018Z","caller":"traceutil/trace.go:171","msg":"trace[278127578] transaction","detail":"{read_only:false; response_revision:4401; number_of_response:1; }","duration":"104.589039ms","start":"2026-06-09T17:14:26.720406Z","end":"2026-06-09T17:14:26.824995Z","steps":["trace[278127578] 'process raft request' (duration: 104.266272ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.826107Z","caller":"traceutil/trace.go:171","msg":"trace[660801884] transaction","detail":"{read_only:false; response_revision:4402; number_of_response:1; }","duration":"104.445446ms","start":"2026-06-09T17:14:26.72164Z","end":"2026-06-09T17:14:26.826086Z","steps":["trace[660801884] 'process raft request' (duration: 103.928765ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.826543Z","caller":"traceutil/trace.go:171","msg":"trace[1761656682] transaction","detail":"{read_only:false; response_revision:4403; number_of_response:1; }","duration":"102.881954ms","start":"2026-06-09T17:14:26.723642Z","end":"2026-06-09T17:14:26.826524Z","steps":["trace[1761656682] 'process raft request' (duration: 102.008905ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:27.657724Z","caller":"traceutil/trace.go:171","msg":"trace[1121176190] transaction","detail":"{read_only:false; response_revision:4477; number_of_response:1; }","duration":"164.828443ms","start":"2026-06-09T17:14:27.492868Z","end":"2026-06-09T17:14:27.657696Z","steps":["trace[1121176190] 'process raft request' (duration: 164.645709ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:27.660939Z","caller":"traceutil/trace.go:171","msg":"trace[770125091] transaction","detail":"{read_only:false; response_revision:4478; number_of_response:1; }","duration":"165.340554ms","start":"2026-06-09T17:14:27.495577Z","end":"2026-06-09T17:14:27.660918Z","steps":["trace[770125091] 'process raft request' (duration: 165.252591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:27.956105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.239258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:27.956303Z","caller":"traceutil/trace.go:171","msg":"trace[87764280] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"266.745003ms","start":"2026-06-09T17:14:27.689537Z","end":"2026-06-09T17:14:27.956282Z","steps":["trace[87764280] 'process raft request' (duration: 49.2442ms)","trace[87764280] 'compare' (duration: 217.094645ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:27.985983Z","caller":"traceutil/trace.go:171","msg":"trace[1392641260] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"245.458022ms","start":"2026-06-09T17:14:27.740502Z","end":"2026-06-09T17:14:27.98596Z","steps":["trace[1392641260] 'process raft request' (duration: 245.35368ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.133683Z","caller":"traceutil/trace.go:171","msg":"trace[403742055] transaction","detail":"{read_only:false; response_revision:4484; number_of_response:1; }","duration":"343.318334ms","start":"2026-06-09T17:14:27.790331Z","end":"2026-06-09T17:14:28.133649Z","steps":["trace[403742055] 'process raft request' (duration: 316.215333ms)","trace[403742055] 'compare' (duration: 26.702272ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:28.133794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:27.790235Z","time spent":"343.507638ms","remote":"127.0.0.1:39928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":804,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:14:28.134633Z","caller":"traceutil/trace.go:171","msg":"trace[146880836] transaction","detail":"{read_only:false; response_revision:4485; number_of_response:1; }","duration":"334.396279ms","start":"2026-06-09T17:14:27.800214Z","end":"2026-06-09T17:14:28.134611Z","steps":["trace[146880836] 'process raft request' (duration: 333.46533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:28.134889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:27.800186Z","time spent":"334.614933ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459345,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:28.135389Z","caller":"traceutil/trace.go:171","msg":"trace[731591352] transaction","detail":"{read_only:false; response_revision:4486; number_of_response:1; }","duration":"328.634449ms","start":"2026-06-09T17:14:27.806718Z","end":"2026-06-09T17:14:28.135352Z","steps":["trace[731591352] 'process raft request' (duration: 327.836072ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.135385Z","caller":"traceutil/trace.go:171","msg":"trace[568820000] linearizableReadLoop","detail":"{readStateIndex:4663; appliedIndex:4657; }","duration":"169.135346ms","start":"2026-06-09T17:14:27.966228Z","end":"2026-06-09T17:14:28.135363Z","steps":["trace[568820000] 'read index received' (duration: 19.616616ms)","trace[568820000] 'applied index is now lower than readState.Index' (duration: 149.51768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:28.135463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:27.806695Z","time spent":"328.72749ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:28.135385Z","caller":"traceutil/trace.go:171","msg":"trace[1436674897] transaction","detail":"{read_only:false; response_revision:4487; number_of_response:1; }","duration":"326.279ms","start":"2026-06-09T17:14:27.80909Z","end":"2026-06-09T17:14:28.135369Z","steps":["trace[1436674897] 'process raft request' (duration: 326.105227ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.135501Z","caller":"traceutil/trace.go:171","msg":"trace[762325528] transaction","detail":"{read_only:false; response_revision:4488; number_of_response:1; }","duration":"284.801741ms","start":"2026-06-09T17:14:27.850689Z","end":"2026-06-09T17:14:28.13549Z","steps":["trace[762325528] 'process raft request' (duration: 284.625378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:28.135525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:27.809071Z","time spent":"326.423593ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:28.135657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.425723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:28.135687Z","caller":"traceutil/trace.go:171","msg":"trace[756572579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4488; }","duration":"169.503654ms","start":"2026-06-09T17:14:27.966175Z","end":"2026-06-09T17:14:28.135678Z","steps":["trace[756572579] 'agreement among raft nodes before linearized reading' (duration: 169.440173ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.303799Z","caller":"traceutil/trace.go:171","msg":"trace[310222512] transaction","detail":"{read_only:false; response_revision:4491; number_of_response:1; }","duration":"150.247925ms","start":"2026-06-09T17:14:28.153528Z","end":"2026-06-09T17:14:28.303776Z","steps":["trace[310222512] 'process raft request' (duration: 150.142273ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.303818Z","caller":"traceutil/trace.go:171","msg":"trace[639181215] transaction","detail":"{read_only:false; response_revision:4490; number_of_response:1; }","duration":"161.781033ms","start":"2026-06-09T17:14:28.141995Z","end":"2026-06-09T17:14:28.303776Z","steps":["trace[639181215] 'process raft request' (duration: 158.725429ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.3042Z","caller":"traceutil/trace.go:171","msg":"trace[1714586861] transaction","detail":"{read_only:false; response_revision:4493; number_of_response:1; }","duration":"139.88047ms","start":"2026-06-09T17:14:28.164296Z","end":"2026-06-09T17:14:28.304176Z","steps":["trace[1714586861] 'process raft request' (duration: 139.651626ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:28.304103Z","caller":"traceutil/trace.go:171","msg":"trace[1904458342] linearizableReadLoop","detail":"{readStateIndex:4668; appliedIndex:4663; }","duration":"126.482763ms","start":"2026-06-09T17:14:28.177598Z","end":"2026-06-09T17:14:28.30408Z","steps":["trace[1904458342] 'read index received' (duration: 5.156246ms)","trace[1904458342] 'applied index is now lower than readState.Index' (duration: 121.325657ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:28.304371Z","caller":"traceutil/trace.go:171","msg":"trace[1006012676] transaction","detail":"{read_only:false; response_revision:4492; number_of_response:1; }","duration":"141.451924ms","start":"2026-06-09T17:14:28.162901Z","end":"2026-06-09T17:14:28.304353Z","steps":["trace[1006012676] 'process raft request' (duration: 140.82375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:28.30445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.834291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-09T17:14:28.304502Z","caller":"traceutil/trace.go:171","msg":"trace[1311816150] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4493; }","duration":"126.937034ms","start":"2026-06-09T17:14:28.177553Z","end":"2026-06-09T17:14:28.30449Z","steps":["trace[1311816150] 'agreement among raft nodes before linearized reading' (duration: 126.757661ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:31.540831Z","caller":"traceutil/trace.go:171","msg":"trace[126882736] transaction","detail":"{read_only:false; response_revision:4549; number_of_response:1; }","duration":"143.694574ms","start":"2026-06-09T17:14:31.397115Z","end":"2026-06-09T17:14:31.540809Z","steps":["trace[126882736] 'process raft request' (duration: 143.56071ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:35.667083Z","caller":"traceutil/trace.go:171","msg":"trace[1194945994] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"114.395515ms","start":"2026-06-09T17:14:35.552667Z","end":"2026-06-09T17:14:35.667062Z","steps":["trace[1194945994] 'process raft request' (duration: 114.284862ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:36.321257Z","caller":"traceutil/trace.go:171","msg":"trace[103931269] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"114.519414ms","start":"2026-06-09T17:14:36.206693Z","end":"2026-06-09T17:14:36.321212Z","steps":["trace[103931269] 'process raft request' (duration: 114.451713ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:36.321353Z","caller":"traceutil/trace.go:171","msg":"trace[235723846] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"130.209483ms","start":"2026-06-09T17:14:36.191061Z","end":"2026-06-09T17:14:36.321271Z","steps":["trace[235723846] 'process raft request' (duration: 129.999749ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:36.321394Z","caller":"traceutil/trace.go:171","msg":"trace[1846902679] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"114.743538ms","start":"2026-06-09T17:14:36.206599Z","end":"2026-06-09T17:14:36.321343Z","steps":["trace[1846902679] 'process raft request' (duration: 114.511024ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:36.321585Z","caller":"traceutil/trace.go:171","msg":"trace[232840286] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"130.788565ms","start":"2026-06-09T17:14:36.190761Z","end":"2026-06-09T17:14:36.321549Z","steps":["trace[232840286] 'process raft request' (duration: 130.182183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:36.321839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.22103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6184dc7d-6eb2-4b59-91f7-194351396b55\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-06-09T17:14:36.321876Z","caller":"traceutil/trace.go:171","msg":"trace[1891312057] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6184dc7d-6eb2-4b59-91f7-194351396b55; range_end:; response_count:1; response_revision:4696; }","duration":"120.313921ms","start":"2026-06-09T17:14:36.201553Z","end":"2026-06-09T17:14:36.321867Z","steps":["trace[1891312057] 'agreement among raft nodes before linearized reading' (duration: 120.145267ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:37.141034Z","caller":"traceutil/trace.go:171","msg":"trace[1632232357] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"160.740081ms","start":"2026-06-09T17:14:36.980266Z","end":"2026-06-09T17:14:37.141006Z","steps":["trace[1632232357] 'process raft request' (duration: 159.908544ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:37.337476Z","caller":"traceutil/trace.go:171","msg":"trace[1585925392] linearizableReadLoop","detail":"{readStateIndex:4904; appliedIndex:4903; }","duration":"184.608964ms","start":"2026-06-09T17:14:37.152841Z","end":"2026-06-09T17:14:37.33745Z","steps":["trace[1585925392] 'read index received' (duration: 184.514082ms)","trace[1585925392] 'applied index is now lower than readState.Index' (duration: 93.592µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:37.337521Z","caller":"traceutil/trace.go:171","msg":"trace[994948958] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"191.23148ms","start":"2026-06-09T17:14:37.146255Z","end":"2026-06-09T17:14:37.337487Z","steps":["trace[994948958] 'process raft request' (duration: 191.042376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:37.33772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.85275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-06-09T17:14:37.337767Z","caller":"traceutil/trace.go:171","msg":"trace[2117326107] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4722; }","duration":"184.970082ms","start":"2026-06-09T17:14:37.152781Z","end":"2026-06-09T17:14:37.337751Z","steps":["trace[2117326107] 'agreement among raft nodes before linearized reading' (duration: 184.790368ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:37.461283Z","caller":"traceutil/trace.go:171","msg":"trace[1711150485] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4904; }","duration":"123.711106ms","start":"2026-06-09T17:14:37.337548Z","end":"2026-06-09T17:14:37.461259Z","steps":["trace[1711150485] 'read index received' (duration: 90.533292ms)","trace[1711150485] 'applied index is now lower than readState.Index' (duration: 33.176444ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:37.461332Z","caller":"traceutil/trace.go:171","msg":"trace[263210293] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"238.121794ms","start":"2026-06-09T17:14:37.223152Z","end":"2026-06-09T17:14:37.461274Z","steps":["trace[263210293] 'process raft request' (duration: 204.937299ms)","trace[263210293] 'compare' (duration: 32.992801ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:37.46141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.388397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:37.46145Z","caller":"traceutil/trace.go:171","msg":"trace[438037320] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4723; }","duration":"263.454738ms","start":"2026-06-09T17:14:37.197982Z","end":"2026-06-09T17:14:37.461437Z","steps":["trace[438037320] 'agreement among raft nodes before linearized reading' (duration: 263.363596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:37.461555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.029215ms","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-06-09T17:14:37.461682Z","caller":"traceutil/trace.go:171","msg":"trace[1123398130] 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:4723; }","duration":"247.179688ms","start":"2026-06-09T17:14:37.214473Z","end":"2026-06-09T17:14:37.461652Z","steps":["trace[1123398130] 'agreement among raft nodes before linearized reading' (duration: 246.80542ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:37.479991Z","caller":"traceutil/trace.go:171","msg":"trace[1295369773] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"132.812341ms","start":"2026-06-09T17:14:37.347108Z","end":"2026-06-09T17:14:37.479921Z","steps":["trace[1295369773] 'process raft request' (duration: 132.630688ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:38.375655Z","caller":"traceutil/trace.go:171","msg":"trace[1522201013] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"143.532984ms","start":"2026-06-09T17:14:38.232091Z","end":"2026-06-09T17:14:38.375624Z","steps":["trace[1522201013] 'process raft request' (duration: 98.393128ms)","trace[1522201013] 'compare' (duration: 44.884482ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:38.37573Z","caller":"traceutil/trace.go:171","msg":"trace[1332186150] linearizableReadLoop","detail":"{readStateIndex:4916; appliedIndex:4912; }","duration":"119.833353ms","start":"2026-06-09T17:14:38.255876Z","end":"2026-06-09T17:14:38.375709Z","steps":["trace[1332186150] 'read index received' (duration: 74.634796ms)","trace[1332186150] 'applied index is now lower than readState.Index' (duration: 45.197537ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:38.376051Z","caller":"traceutil/trace.go:171","msg":"trace[654674632] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"120.357514ms","start":"2026-06-09T17:14:38.255677Z","end":"2026-06-09T17:14:38.376035Z","steps":["trace[654674632] 'process raft request' (duration: 119.969966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:38.376102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.203131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:38.376158Z","caller":"traceutil/trace.go:171","msg":"trace[1344587368] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:4733; }","duration":"120.300553ms","start":"2026-06-09T17:14:38.255842Z","end":"2026-06-09T17:14:38.376143Z","steps":["trace[1344587368] 'agreement among raft nodes before linearized reading' (duration: 120.201061ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:38.37624Z","caller":"traceutil/trace.go:171","msg":"trace[828890682] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"133.505921ms","start":"2026-06-09T17:14:38.242724Z","end":"2026-06-09T17:14:38.376229Z","steps":["trace[828890682] 'process raft request' (duration: 132.788826ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:38.376372Z","caller":"traceutil/trace.go:171","msg":"trace[1696625013] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"132.453859ms","start":"2026-06-09T17:14:38.243909Z","end":"2026-06-09T17:14:38.376363Z","steps":["trace[1696625013] 'process raft request' (duration: 131.681174ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:39.551012Z","caller":"traceutil/trace.go:171","msg":"trace[1054296199] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"119.998712ms","start":"2026-06-09T17:14:39.430991Z","end":"2026-06-09T17:14:39.55099Z","steps":["trace[1054296199] 'process raft request' (duration: 119.736217ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:45.555031Z","caller":"traceutil/trace.go:171","msg":"trace[581807329] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"248.791092ms","start":"2026-06-09T17:14:45.306204Z","end":"2026-06-09T17:14:45.554995Z","steps":["trace[581807329] 'process raft request' (duration: 246.938256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:45.786116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.348244ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:45.78626Z","caller":"traceutil/trace.go:171","msg":"trace[371196440] linearizableReadLoop","detail":"{readStateIndex:5031; appliedIndex:5029; }","duration":"396.613209ms","start":"2026-06-09T17:14:45.389626Z","end":"2026-06-09T17:14:45.786239Z","steps":["trace[371196440] 'read index received' (duration: 163.49104ms)","trace[371196440] 'applied index is now lower than readState.Index' (duration: 233.119739ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:45.786363Z","caller":"traceutil/trace.go:171","msg":"trace[192075133] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"478.86897ms","start":"2026-06-09T17:14:45.307479Z","end":"2026-06-09T17:14:45.786348Z","steps":["trace[192075133] 'process raft request' (duration: 377.122777ms)","trace[192075133] 'compare' (duration: 100.940656ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:45.786438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.307444Z","time spent":"478.962302ms","remote":"127.0.0.1:39928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:45.786779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.023324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-365d2c92-8073-425b-9aaf-d0c2b6088e2b\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-06-09T17:14:45.787494Z","caller":"traceutil/trace.go:171","msg":"trace[1606259292] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-365d2c92-8073-425b-9aaf-d0c2b6088e2b; range_end:; response_count:1; response_revision:4846; }","duration":"343.785279ms","start":"2026-06-09T17:14:45.44369Z","end":"2026-06-09T17:14:45.787476Z","steps":["trace[1606259292] 'agreement among raft nodes before linearized reading' (duration: 342.677107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:45.786778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.472627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-06-09T17:14:45.787582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.443645Z","time spent":"343.909992ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3788,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-365d2c92-8073-425b-9aaf-d0c2b6088e2b\" "} {"level":"warn","ts":"2026-06-09T17:14:45.786778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.303215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-09T17:14:45.787708Z","caller":"traceutil/trace.go:171","msg":"trace[867572471] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4846; }","duration":"273.254455ms","start":"2026-06-09T17:14:45.514439Z","end":"2026-06-09T17:14:45.787694Z","steps":["trace[867572471] 'agreement among raft nodes before linearized reading' (duration: 272.107562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:45.786881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.254063ms","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-06-09T17:14:45.787894Z","caller":"traceutil/trace.go:171","msg":"trace[130718228] 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:4846; }","duration":"398.294224ms","start":"2026-06-09T17:14:45.389585Z","end":"2026-06-09T17:14:45.787879Z","steps":["trace[130718228] 'agreement among raft nodes before linearized reading' (duration: 396.785523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:45.787931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:45.389567Z","time spent":"398.350745ms","remote":"127.0.0.1:40008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-09T17:14:45.78695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.837552ms","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-06-09T17:14:45.788103Z","caller":"traceutil/trace.go:171","msg":"trace[1731898772] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4846; }","duration":"227.069997ms","start":"2026-06-09T17:14:45.561022Z","end":"2026-06-09T17:14:45.788092Z","steps":["trace[1731898772] 'agreement among raft nodes before linearized reading' (duration: 225.686379ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:45.787675Z","caller":"traceutil/trace.go:171","msg":"trace[2127756054] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4846; }","duration":"274.351005ms","start":"2026-06-09T17:14:45.513246Z","end":"2026-06-09T17:14:45.787597Z","steps":["trace[2127756054] 'agreement among raft nodes before linearized reading' (duration: 273.388646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.482913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.575607ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:46.48312Z","caller":"traceutil/trace.go:171","msg":"trace[1936562070] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4854; }","duration":"415.76666ms","start":"2026-06-09T17:14:46.067305Z","end":"2026-06-09T17:14:46.483072Z","steps":["trace[1936562070] 'range keys from in-memory index tree' (duration: 415.557547ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:46.660159Z","caller":"traceutil/trace.go:171","msg":"trace[469423488] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"172.316553ms","start":"2026-06-09T17:14:46.487823Z","end":"2026-06-09T17:14:46.660139Z","steps":["trace[469423488] 'process raft request' (duration: 172.18879ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:46.792571Z","caller":"traceutil/trace.go:171","msg":"trace[1257249459] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5039; }","duration":"300.433349ms","start":"2026-06-09T17:14:46.492112Z","end":"2026-06-09T17:14:46.792545Z","steps":["trace[1257249459] 'read index received' (duration: 167.998636ms)","trace[1257249459] 'applied index is now lower than readState.Index' (duration: 132.433133ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:46.792765Z","caller":"traceutil/trace.go:171","msg":"trace[224365941] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"304.869018ms","start":"2026-06-09T17:14:46.487873Z","end":"2026-06-09T17:14:46.792742Z","steps":["trace[224365941] 'process raft request' (duration: 219.593489ms)","trace[224365941] 'compare' (duration: 84.352341ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:46.792877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:46.487855Z","time spent":"304.939729ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:46.793007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.763012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T17:14:46.793087Z","caller":"traceutil/trace.go:171","msg":"trace[2144242619] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4856; }","duration":"196.914536ms","start":"2026-06-09T17:14:46.596158Z","end":"2026-06-09T17:14:46.793073Z","steps":["trace[2144242619] 'agreement among raft nodes before linearized reading' (duration: 196.6182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.793273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.758632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T17:14:46.793329Z","caller":"traceutil/trace.go:171","msg":"trace[642987361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4856; }","duration":"184.863604ms","start":"2026-06-09T17:14:46.608454Z","end":"2026-06-09T17:14:46.793317Z","steps":["trace[642987361] 'agreement among raft nodes before linearized reading' (duration: 184.65458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.793337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.760482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:14:46.793358Z","caller":"traceutil/trace.go:171","msg":"trace[1370704248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4856; }","duration":"187.821303ms","start":"2026-06-09T17:14:46.60553Z","end":"2026-06-09T17:14:46.793352Z","steps":["trace[1370704248] 'agreement among raft nodes before linearized reading' (duration: 187.774703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.793455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.855174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-09T17:14:46.793669Z","caller":"traceutil/trace.go:171","msg":"trace[624283949] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4856; }","duration":"194.119089ms","start":"2026-06-09T17:14:46.599543Z","end":"2026-06-09T17:14:46.793662Z","steps":["trace[624283949] 'agreement among raft nodes before linearized reading' (duration: 193.872095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.793273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.748501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-09T17:14:46.793731Z","caller":"traceutil/trace.go:171","msg":"trace[838395653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4856; }","duration":"188.257362ms","start":"2026-06-09T17:14:46.605468Z","end":"2026-06-09T17:14:46.793725Z","steps":["trace[838395653] 'agreement among raft nodes before linearized reading' (duration: 187.6644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.793862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.756836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"info","ts":"2026-06-09T17:14:46.793893Z","caller":"traceutil/trace.go:171","msg":"trace[1993154403] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4856; }","duration":"301.797077ms","start":"2026-06-09T17:14:46.492081Z","end":"2026-06-09T17:14:46.793878Z","steps":["trace[1993154403] 'agreement among raft nodes before linearized reading' (duration: 301.739616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:46.79391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:46.492066Z","time spent":"301.838708ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1184,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"warn","ts":"2026-06-09T17:14:46.795339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.689471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T17:14:46.795405Z","caller":"traceutil/trace.go:171","msg":"trace[1892143241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4856; }","duration":"192.772952ms","start":"2026-06-09T17:14:46.602619Z","end":"2026-06-09T17:14:46.795392Z","steps":["trace[1892143241] 'agreement among raft nodes before linearized reading' (duration: 190.67446ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:45.826325Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2849} {"level":"info","ts":"2026-06-09T17:15:45.909849Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2849,"took":"81.817094ms","hash":1005063413,"current-db-size-bytes":53436416,"current-db-size":"53 MB","current-db-size-in-use-bytes":28499968,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-09T17:15:45.90992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1005063413,"revision":2849,"compact-revision":-1} {"level":"info","ts":"2026-06-09T17:15:51.440349Z","caller":"traceutil/trace.go:171","msg":"trace[922489983] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"117.796984ms","start":"2026-06-09T17:15:51.322504Z","end":"2026-06-09T17:15:51.440301Z","steps":["trace[922489983] 'process raft request' (duration: 55.679193ms)","trace[922489983] 'compare' (duration: 61.851347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:16:18.389052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280268701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:16:19.024196Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280268701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:16:19.298946Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.140710438s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T17:16:19.299417Z","caller":"traceutil/trace.go:171","msg":"trace[2037849385] transaction","detail":"{read_only:false; response_revision:5656; number_of_response:1; }","duration":"2.141243877s","start":"2026-06-09T17:16:17.158146Z","end":"2026-06-09T17:16:19.29939Z","steps":["trace[2037849385] 'process raft request' (duration: 2.141027453s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:16:19.299535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:16:17.158128Z","time spent":"2.141329328s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:16:19.343004Z","caller":"traceutil/trace.go:171","msg":"trace[613083043] transaction","detail":"{read_only:false; response_revision:5657; number_of_response:1; }","duration":"1.866035794s","start":"2026-06-09T17:16:17.476928Z","end":"2026-06-09T17:16:19.342964Z","steps":["trace[613083043] 'process raft request' (duration: 1.865304171s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:16:19.343162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:16:17.476919Z","time spent":"1.866164057s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:16:19.343288Z","caller":"traceutil/trace.go:171","msg":"trace[2138370480] linearizableReadLoop","detail":"{readStateIndex:5867; appliedIndex:5866; }","duration":"1.913414003s","start":"2026-06-09T17:16:17.429849Z","end":"2026-06-09T17:16:19.343263Z","steps":["trace[2138370480] 'read index received' (duration: 1.87134665s)","trace[2138370480] 'applied index is now lower than readState.Index' (duration: 42.063952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:16:19.343592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.913721429s","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-06-09T17:16:19.343662Z","caller":"traceutil/trace.go:171","msg":"trace[2128094796] 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:5658; }","duration":"1.91380612s","start":"2026-06-09T17:16:17.429845Z","end":"2026-06-09T17:16:19.343651Z","steps":["trace[2128094796] 'agreement among raft nodes before linearized reading' (duration: 1.913551776s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:16:19.344126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:16:17.429826Z","time spent":"1.91429058s","remote":"127.0.0.1:40008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-09T17:16:19.344199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.868967756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:16:19.344296Z","caller":"traceutil/trace.go:171","msg":"trace[183575715] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5660; }","duration":"1.869117919s","start":"2026-06-09T17:16:17.475154Z","end":"2026-06-09T17:16:19.344272Z","steps":["trace[183575715] 'agreement among raft nodes before linearized reading' (duration: 1.868950016s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:16:19.344338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:16:17.475146Z","time spent":"1.86918283s","remote":"127.0.0.1:48516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:16:19.345061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.838754335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:16:19.345088Z","caller":"traceutil/trace.go:171","msg":"trace[1727768100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5660; }","duration":"1.838809536s","start":"2026-06-09T17:16:17.506271Z","end":"2026-06-09T17:16:19.345081Z","steps":["trace[1727768100] 'agreement among raft nodes before linearized reading' (duration: 1.838736715s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:16:19.345111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:16:17.506258Z","time spent":"1.838848587s","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T17:17:34.561981Z","caller":"traceutil/trace.go:171","msg":"trace[1251758606] transaction","detail":"{read_only:false; response_revision:6100; number_of_response:1; }","duration":"122.013794ms","start":"2026-06-09T17:17:34.439944Z","end":"2026-06-09T17:17:34.561958Z","steps":["trace[1251758606] 'process raft request' (duration: 121.846601ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:34.980797Z","caller":"traceutil/trace.go:171","msg":"trace[654920527] transaction","detail":"{read_only:false; response_revision:6101; number_of_response:1; }","duration":"166.894566ms","start":"2026-06-09T17:17:34.813822Z","end":"2026-06-09T17:17:34.980716Z","steps":["trace[654920527] 'process raft request' (duration: 166.46316ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.064681Z","caller":"traceutil/trace.go:171","msg":"trace[1189698058] transaction","detail":"{read_only:false; response_revision:6102; number_of_response:1; }","duration":"233.690282ms","start":"2026-06-09T17:17:34.830952Z","end":"2026-06-09T17:17:35.064642Z","steps":["trace[1189698058] 'process raft request' (duration: 233.469798ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.064786Z","caller":"traceutil/trace.go:171","msg":"trace[136039660] transaction","detail":"{read_only:false; response_revision:6103; number_of_response:1; }","duration":"123.299376ms","start":"2026-06-09T17:17:34.941471Z","end":"2026-06-09T17:17:35.06477Z","steps":["trace[136039660] 'process raft request' (duration: 123.097093ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.932994Z","caller":"traceutil/trace.go:171","msg":"trace[1385430345] transaction","detail":"{read_only:false; response_revision:6110; number_of_response:1; }","duration":"130.589598ms","start":"2026-06-09T17:17:35.802377Z","end":"2026-06-09T17:17:35.932967Z","steps":["trace[1385430345] 'process raft request' (duration: 130.173552ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.955815Z","caller":"traceutil/trace.go:171","msg":"trace[1496875341] linearizableReadLoop","detail":"{readStateIndex:6341; appliedIndex:6336; }","duration":"138.749777ms","start":"2026-06-09T17:17:35.817036Z","end":"2026-06-09T17:17:35.955786Z","steps":["trace[1496875341] 'read index received' (duration: 115.643295ms)","trace[1496875341] 'applied index is now lower than readState.Index' (duration: 23.106052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:17:35.955967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.910899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-domain-manage-z27p2\" ","response":"range_response_count:1 size:8151"} {"level":"info","ts":"2026-06-09T17:17:35.955998Z","caller":"traceutil/trace.go:171","msg":"trace[21359110] range","detail":"{range_begin:/registry/pods/openstack/keystone-domain-manage-z27p2; range_end:; response_count:1; response_revision:6114; }","duration":"138.981701ms","start":"2026-06-09T17:17:35.81701Z","end":"2026-06-09T17:17:35.955991Z","steps":["trace[21359110] 'agreement among raft nodes before linearized reading' (duration: 138.842459ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.956151Z","caller":"traceutil/trace.go:171","msg":"trace[276845125] transaction","detail":"{read_only:false; response_revision:6113; number_of_response:1; }","duration":"153.309075ms","start":"2026-06-09T17:17:35.802828Z","end":"2026-06-09T17:17:35.956138Z","steps":["trace[276845125] 'process raft request' (duration: 152.908528ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.956203Z","caller":"traceutil/trace.go:171","msg":"trace[1342488542] transaction","detail":"{read_only:false; response_revision:6111; number_of_response:1; }","duration":"153.549609ms","start":"2026-06-09T17:17:35.802639Z","end":"2026-06-09T17:17:35.956188Z","steps":["trace[1342488542] 'process raft request' (duration: 152.976809ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.956255Z","caller":"traceutil/trace.go:171","msg":"trace[1153478016] transaction","detail":"{read_only:false; response_revision:6114; number_of_response:1; }","duration":"152.201816ms","start":"2026-06-09T17:17:35.804044Z","end":"2026-06-09T17:17:35.956246Z","steps":["trace[1153478016] 'process raft request' (duration: 151.714568ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:35.95611Z","caller":"traceutil/trace.go:171","msg":"trace[2038544931] transaction","detail":"{read_only:false; response_revision:6112; number_of_response:1; }","duration":"153.364055ms","start":"2026-06-09T17:17:35.802701Z","end":"2026-06-09T17:17:35.956065Z","steps":["trace[2038544931] 'process raft request' (duration: 153.00715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:17:36.260476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.944103ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:17:36.260602Z","caller":"traceutil/trace.go:171","msg":"trace[117633990] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6115; }","duration":"194.080116ms","start":"2026-06-09T17:17:36.066505Z","end":"2026-06-09T17:17:36.260585Z","steps":["trace[117633990] 'range keys from in-memory index tree' (duration: 193.929203ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:37.817909Z","caller":"traceutil/trace.go:171","msg":"trace[1794653745] transaction","detail":"{read_only:false; response_revision:6118; number_of_response:1; }","duration":"177.725697ms","start":"2026-06-09T17:17:37.640152Z","end":"2026-06-09T17:17:37.817878Z","steps":["trace[1794653745] 'process raft request' (duration: 98.145916ms)","trace[1794653745] 'compare' (duration: 79.359957ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:37.818229Z","caller":"traceutil/trace.go:171","msg":"trace[403338562] transaction","detail":"{read_only:false; response_revision:6119; number_of_response:1; }","duration":"175.994677ms","start":"2026-06-09T17:17:37.642221Z","end":"2026-06-09T17:17:37.818216Z","steps":["trace[403338562] 'process raft request' (duration: 175.604101ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:40.140248Z","caller":"traceutil/trace.go:171","msg":"trace[952337531] transaction","detail":"{read_only:false; response_revision:6133; number_of_response:1; }","duration":"109.13371ms","start":"2026-06-09T17:17:40.031054Z","end":"2026-06-09T17:17:40.140187Z","steps":["trace[952337531] 'process raft request' (duration: 37.324942ms)","trace[952337531] 'compare' (duration: 71.581195ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:40.140325Z","caller":"traceutil/trace.go:171","msg":"trace[482669302] transaction","detail":"{read_only:false; response_revision:6135; number_of_response:1; }","duration":"108.258945ms","start":"2026-06-09T17:17:40.032007Z","end":"2026-06-09T17:17:40.140266Z","steps":["trace[482669302] 'process raft request' (duration: 108.183904ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:40.140451Z","caller":"traceutil/trace.go:171","msg":"trace[1216908279] transaction","detail":"{read_only:false; response_revision:6134; number_of_response:1; }","duration":"109.334003ms","start":"2026-06-09T17:17:40.031107Z","end":"2026-06-09T17:17:40.140441Z","steps":["trace[1216908279] 'process raft request' (duration: 109.024328ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:42.254573Z","caller":"traceutil/trace.go:171","msg":"trace[728001504] transaction","detail":"{read_only:false; response_revision:6144; number_of_response:1; }","duration":"104.911207ms","start":"2026-06-09T17:17:42.149634Z","end":"2026-06-09T17:17:42.254545Z","steps":["trace[728001504] 'process raft request' (duration: 93.429892ms)","trace[728001504] 'compare' (duration: 11.259491ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:17:42.254953Z","caller":"traceutil/trace.go:171","msg":"trace[520711478] transaction","detail":"{read_only:false; response_revision:6145; number_of_response:1; }","duration":"104.543141ms","start":"2026-06-09T17:17:42.150396Z","end":"2026-06-09T17:17:42.254939Z","steps":["trace[520711478] 'process raft request' (duration: 104.037382ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:44.388518Z","caller":"traceutil/trace.go:171","msg":"trace[2012234941] transaction","detail":"{read_only:false; response_revision:6154; number_of_response:1; }","duration":"118.298331ms","start":"2026-06-09T17:17:44.270173Z","end":"2026-06-09T17:17:44.388471Z","steps":["trace[2012234941] 'process raft request' (duration: 111.368124ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:44.390084Z","caller":"traceutil/trace.go:171","msg":"trace[96110369] transaction","detail":"{read_only:false; response_revision:6155; number_of_response:1; }","duration":"118.502234ms","start":"2026-06-09T17:17:44.271556Z","end":"2026-06-09T17:17:44.390058Z","steps":["trace[96110369] 'process raft request' (duration: 118.368232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:17:46.235682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.152653ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:17:46.235788Z","caller":"traceutil/trace.go:171","msg":"trace[569510059] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6162; }","duration":"168.274095ms","start":"2026-06-09T17:17:46.067499Z","end":"2026-06-09T17:17:46.235773Z","steps":["trace[569510059] 'range keys from in-memory index tree' (duration: 168.140552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:17:46.236166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.689269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T17:17:46.236198Z","caller":"traceutil/trace.go:171","msg":"trace[1828510345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6162; }","duration":"136.760581ms","start":"2026-06-09T17:17:46.09943Z","end":"2026-06-09T17:17:46.23619Z","steps":["trace[1828510345] 'range keys from in-memory index tree' (duration: 136.588838ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:17:46.442561Z","caller":"traceutil/trace.go:171","msg":"trace[1157379036] transaction","detail":"{read_only:false; response_revision:6165; number_of_response:1; }","duration":"180.676484ms","start":"2026-06-09T17:17:46.261868Z","end":"2026-06-09T17:17:46.442544Z","steps":["trace[1157379036] 'process raft request' (duration: 175.883672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:23.728362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280270838,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:18:24.2288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280270838,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:18:24.445683Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.219625199s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T17:18:24.44605Z","caller":"traceutil/trace.go:171","msg":"trace[1907223526] transaction","detail":"{read_only:false; response_revision:6504; number_of_response:1; }","duration":"1.220063575s","start":"2026-06-09T17:18:23.225965Z","end":"2026-06-09T17:18:24.446028Z","steps":["trace[1907223526] 'process raft request' (duration: 1.219918043s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.446201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.225956Z","time spent":"1.220174248s","remote":"127.0.0.1:40140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1325,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:24.450279Z","caller":"traceutil/trace.go:171","msg":"trace[1988202063] transaction","detail":"{read_only:false; response_revision:6506; number_of_response:1; }","duration":"601.820815ms","start":"2026-06-09T17:18:23.84843Z","end":"2026-06-09T17:18:24.450251Z","steps":["trace[1988202063] 'process raft request' (duration: 601.712614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.450434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.848401Z","time spent":"601.935018ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:24.450674Z","caller":"traceutil/trace.go:171","msg":"trace[1554084032] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"1.224393318s","start":"2026-06-09T17:18:23.226266Z","end":"2026-06-09T17:18:24.45066Z","steps":["trace[1554084032] 'process raft request' (duration: 1.223706926s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.450714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.226258Z","time spent":"1.224433658s","remote":"127.0.0.1:40010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:24.465927Z","caller":"traceutil/trace.go:171","msg":"trace[1480119389] linearizableReadLoop","detail":"{readStateIndex:6747; appliedIndex:6743; }","duration":"1.238209156s","start":"2026-06-09T17:18:23.227697Z","end":"2026-06-09T17:18:24.465906Z","steps":["trace[1480119389] 'read index received' (duration: 1.218256385s)","trace[1480119389] 'applied index is now lower than readState.Index' (duration: 19.951661ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:18:24.466131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.468715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:24.466169Z","caller":"traceutil/trace.go:171","msg":"trace[365861465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:6509; }","duration":"975.561967ms","start":"2026-06-09T17:18:23.490593Z","end":"2026-06-09T17:18:24.466155Z","steps":["trace[365861465] 'agreement among raft nodes before linearized reading' (duration: 975.485956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.466201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.490574Z","time spent":"975.619508ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:24.466252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238539853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-init-h468z\" ","response":"range_response_count:1 size:6156"} {"level":"info","ts":"2026-06-09T17:18:24.466375Z","caller":"traceutil/trace.go:171","msg":"trace[740016210] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-init-h468z; range_end:; response_count:1; response_revision:6509; }","duration":"1.238712545s","start":"2026-06-09T17:18:23.227643Z","end":"2026-06-09T17:18:24.466355Z","steps":["trace[740016210] 'agreement among raft nodes before linearized reading' (duration: 1.23838706s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.466433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.227627Z","time spent":"1.238800206s","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6178,"request content":"key:\"/registry/pods/openstack/horizon-db-init-h468z\" "} {"level":"warn","ts":"2026-06-09T17:18:24.466698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.257349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:24.46674Z","caller":"traceutil/trace.go:171","msg":"trace[809910203] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:6509; }","duration":"618.374711ms","start":"2026-06-09T17:18:23.848353Z","end":"2026-06-09T17:18:24.466727Z","steps":["trace[809910203] 'agreement among raft nodes before linearized reading' (duration: 618.3174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.466769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.848324Z","time spent":"618.437953ms","remote":"127.0.0.1:57370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:24.46689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.395551ms","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-06-09T17:18:24.466918Z","caller":"traceutil/trace.go:171","msg":"trace[1470054762] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:6509; }","duration":"794.465582ms","start":"2026-06-09T17:18:23.672445Z","end":"2026-06-09T17:18:24.466911Z","steps":["trace[1470054762] 'agreement among raft nodes before linearized reading' (duration: 794.35455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.466938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.672424Z","time spent":"794.509993ms","remote":"127.0.0.1:39942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":81,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:24.467094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.527043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-09T17:18:24.467165Z","caller":"traceutil/trace.go:171","msg":"trace[1077520448] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6509; }","duration":"639.642054ms","start":"2026-06-09T17:18:23.827505Z","end":"2026-06-09T17:18:24.467147Z","steps":["trace[1077520448] 'agreement among raft nodes before linearized reading' (duration: 639.503412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:24.467201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:23.827489Z","time spent":"639.705366ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-09T17:18:28.501859Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":653759363280270870,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:18:28.552112Z","caller":"traceutil/trace.go:171","msg":"trace[760235950] transaction","detail":"{read_only:false; response_revision:6517; number_of_response:1; }","duration":"597.705742ms","start":"2026-06-09T17:18:27.954385Z","end":"2026-06-09T17:18:28.55209Z","steps":["trace[760235950] 'process raft request' (duration: 597.526719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.552469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954374Z","time spent":"597.836854ms","remote":"127.0.0.1:39928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:18:28.556097Z","caller":"traceutil/trace.go:171","msg":"trace[734954077] transaction","detail":"{read_only:false; response_revision:6520; number_of_response:1; }","duration":"601.165259ms","start":"2026-06-09T17:18:27.954914Z","end":"2026-06-09T17:18:28.556079Z","steps":["trace[734954077] 'process raft request' (duration: 601.021217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.556218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954909Z","time spent":"601.24197ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:28.556345Z","caller":"traceutil/trace.go:171","msg":"trace[1034008663] transaction","detail":"{read_only:false; response_revision:6518; number_of_response:1; }","duration":"601.558225ms","start":"2026-06-09T17:18:27.954775Z","end":"2026-06-09T17:18:28.556333Z","steps":["trace[1034008663] 'process raft request' (duration: 600.988565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.556388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.95477Z","time spent":"601.591297ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:28.556456Z","caller":"traceutil/trace.go:171","msg":"trace[1970446272] transaction","detail":"{read_only:false; response_revision:6519; number_of_response:1; }","duration":"601.639467ms","start":"2026-06-09T17:18:27.954808Z","end":"2026-06-09T17:18:28.556447Z","steps":["trace[1970446272] 'process raft request' (duration: 601.084608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.556556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954793Z","time spent":"601.735848ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:28.556679Z","caller":"traceutil/trace.go:171","msg":"trace[1257007157] transaction","detail":"{read_only:false; response_revision:6521; number_of_response:1; }","duration":"601.743229ms","start":"2026-06-09T17:18:27.954926Z","end":"2026-06-09T17:18:28.556669Z","steps":["trace[1257007157] 'process raft request' (duration: 601.094428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.556717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.95491Z","time spent":"601.7851ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:18:28.55692Z","caller":"traceutil/trace.go:171","msg":"trace[1366146014] linearizableReadLoop","detail":"{readStateIndex:6763; appliedIndex:6758; }","duration":"602.230397ms","start":"2026-06-09T17:18:27.954679Z","end":"2026-06-09T17:18:28.556909Z","steps":["trace[1366146014] 'read index received' (duration: 598.24599ms)","trace[1366146014] 'applied index is now lower than readState.Index' (duration: 3.983117ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:18:28.557014Z","caller":"traceutil/trace.go:171","msg":"trace[1340968586] transaction","detail":"{read_only:false; response_revision:6522; number_of_response:1; }","duration":"554.896499ms","start":"2026-06-09T17:18:28.002109Z","end":"2026-06-09T17:18:28.557006Z","steps":["trace[1340968586] 'process raft request' (duration: 554.519564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.557058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:28.002098Z","time spent":"554.937511ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:18:28.557327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.537662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:28.557366Z","caller":"traceutil/trace.go:171","msg":"trace[542859220] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6522; }","duration":"602.710085ms","start":"2026-06-09T17:18:27.954645Z","end":"2026-06-09T17:18:28.557355Z","steps":["trace[542859220] 'agreement among raft nodes before linearized reading' (duration: 602.543451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.557401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954629Z","time spent":"602.760526ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-06-09T17:18:28.557634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.890538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T17:18:28.557684Z","caller":"traceutil/trace.go:171","msg":"trace[2004448877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6522; }","duration":"602.949329ms","start":"2026-06-09T17:18:27.954721Z","end":"2026-06-09T17:18:28.557671Z","steps":["trace[2004448877] 'agreement among raft nodes before linearized reading' (duration: 602.800616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.557715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954716Z","time spent":"602.990489ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T17:18:28.557765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.746576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:18:28.557811Z","caller":"traceutil/trace.go:171","msg":"trace[1438726943] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:6522; }","duration":"602.798646ms","start":"2026-06-09T17:18:27.955Z","end":"2026-06-09T17:18:28.557799Z","steps":["trace[1438726943] 'agreement among raft nodes before linearized reading' (duration: 602.720895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.557847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954997Z","time spent":"602.840917ms","remote":"127.0.0.1:40390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:28.557904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.893138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:28.557948Z","caller":"traceutil/trace.go:171","msg":"trace[803910709] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:6522; }","duration":"602.944149ms","start":"2026-06-09T17:18:27.954991Z","end":"2026-06-09T17:18:28.557935Z","steps":["trace[803910709] 'agreement among raft nodes before linearized reading' (duration: 602.876007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.557979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954986Z","time spent":"602.98343ms","remote":"127.0.0.1:55322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:28.558059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.41313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T17:18:28.558091Z","caller":"traceutil/trace.go:171","msg":"trace[1654610658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6522; }","duration":"596.451121ms","start":"2026-06-09T17:18:27.961629Z","end":"2026-06-09T17:18:28.55808Z","steps":["trace[1654610658] 'agreement among raft nodes before linearized reading' (duration: 596.359589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.558125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.961626Z","time spent":"596.491331ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T17:18:28.558093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.540956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-init-h468z\" ","response":"range_response_count:1 size:6391"} {"level":"warn","ts":"2026-06-09T17:18:28.558232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.259245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:18:28.558243Z","caller":"traceutil/trace.go:171","msg":"trace[1900120210] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-init-h468z; range_end:; response_count:1; response_revision:6522; }","duration":"580.731439ms","start":"2026-06-09T17:18:27.97748Z","end":"2026-06-09T17:18:28.558211Z","steps":["trace[1900120210] 'agreement among raft nodes before linearized reading' (duration: 580.333332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.558277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.654754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T17:18:28.558309Z","caller":"traceutil/trace.go:171","msg":"trace[310654162] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6522; }","duration":"596.687764ms","start":"2026-06-09T17:18:27.961613Z","end":"2026-06-09T17:18:28.5583Z","steps":["trace[310654162] 'agreement among raft nodes before linearized reading' (duration: 596.578272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.55832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.354336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:18:28.55832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.977464Z","time spent":"580.841011ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6413,"request content":"key:\"/registry/pods/openstack/horizon-db-init-h468z\" "} {"level":"warn","ts":"2026-06-09T17:18:28.558349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.961577Z","time spent":"596.763286ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T17:18:28.558392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.503398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:28.558426Z","caller":"traceutil/trace.go:171","msg":"trace[220029648] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6522; }","duration":"603.547069ms","start":"2026-06-09T17:18:27.95487Z","end":"2026-06-09T17:18:28.558417Z","steps":["trace[220029648] 'agreement among raft nodes before linearized reading' (duration: 603.496428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.558459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954863Z","time spent":"603.588469ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-06-09T17:18:28.558469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.706121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-09T17:18:28.558495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.404937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:18:28.558536Z","caller":"traceutil/trace.go:171","msg":"trace[1608140212] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:6522; }","duration":"603.445407ms","start":"2026-06-09T17:18:27.955079Z","end":"2026-06-09T17:18:28.558524Z","steps":["trace[1608140212] 'agreement among raft nodes before linearized reading' (duration: 603.382546ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:28.558273Z","caller":"traceutil/trace.go:171","msg":"trace[1253673732] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:6522; }","duration":"603.305765ms","start":"2026-06-09T17:18:27.954956Z","end":"2026-06-09T17:18:28.558262Z","steps":["trace[1253673732] 'agreement among raft nodes before linearized reading' (duration: 603.248395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.558572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.955015Z","time spent":"603.546629ms","remote":"127.0.0.1:48508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:18:28.558581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.613333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:18:28.558585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954952Z","time spent":"603.6222ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:18:28.558609Z","caller":"traceutil/trace.go:171","msg":"trace[1050467479] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6522; }","duration":"339.677544ms","start":"2026-06-09T17:18:28.218924Z","end":"2026-06-09T17:18:28.558601Z","steps":["trace[1050467479] 'agreement among raft nodes before linearized reading' (duration: 339.627953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.558641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:28.218905Z","time spent":"339.730545ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-06-09T17:18:28.55835Z","caller":"traceutil/trace.go:171","msg":"trace[1482779416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6522; }","duration":"603.392687ms","start":"2026-06-09T17:18:27.954948Z","end":"2026-06-09T17:18:28.558341Z","steps":["trace[1482779416] 'agreement among raft nodes before linearized reading' (duration: 603.347566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.562649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954943Z","time spent":"607.636747ms","remote":"127.0.0.1:39860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T17:18:28.558502Z","caller":"traceutil/trace.go:171","msg":"trace[878266370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6522; }","duration":"603.744792ms","start":"2026-06-09T17:18:27.954747Z","end":"2026-06-09T17:18:28.558492Z","steps":["trace[878266370] 'agreement among raft nodes before linearized reading' (duration: 603.659971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.56288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954744Z","time spent":"608.106954ms","remote":"127.0.0.1:40124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T17:18:28.558184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.192313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-09T17:18:28.56305Z","caller":"traceutil/trace.go:171","msg":"trace[183518455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6522; }","duration":"608.052504ms","start":"2026-06-09T17:18:27.954977Z","end":"2026-06-09T17:18:28.563029Z","steps":["trace[183518455] 'agreement among raft nodes before linearized reading' (duration: 603.140852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:18:28.563079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:18:27.954974Z","time spent":"608.096654ms","remote":"127.0.0.1:40124","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-06-09T17:19:17.717634Z","caller":"traceutil/trace.go:171","msg":"trace[920391707] transaction","detail":"{read_only:false; response_revision:6863; number_of_response:1; }","duration":"152.089114ms","start":"2026-06-09T17:19:17.565527Z","end":"2026-06-09T17:19:17.717616Z","steps":["trace[920391707] 'process raft request' (duration: 151.940448ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:20:35.640877Z","caller":"traceutil/trace.go:171","msg":"trace[590556215] transaction","detail":"{read_only:false; response_revision:7281; number_of_response:1; }","duration":"254.731825ms","start":"2026-06-09T17:20:35.386115Z","end":"2026-06-09T17:20:35.640847Z","steps":["trace[590556215] 'process raft request' (duration: 188.861664ms)","trace[590556215] 'compare' (duration: 65.718716ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:20:35.640967Z","caller":"traceutil/trace.go:171","msg":"trace[395002822] transaction","detail":"{read_only:false; response_revision:7282; number_of_response:1; }","duration":"254.553119ms","start":"2026-06-09T17:20:35.386397Z","end":"2026-06-09T17:20:35.64095Z","steps":["trace[395002822] 'process raft request' (duration: 254.413925ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:20:45.832635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5437} {"level":"info","ts":"2026-06-09T17:20:45.907111Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5437,"took":"73.041799ms","hash":2240554669,"current-db-size-bytes":53436416,"current-db-size":"53 MB","current-db-size-in-use-bytes":18456576,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T17:20:45.907416Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2240554669,"revision":5437,"compact-revision":2849}