{"level":"warn","ts":"2026-05-27T09:47:03.134552Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-27T09:47:03.134639Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.61: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.61:2380","--initial-cluster=instance=https://199.19.213.61:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.61:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.61:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-27T09:47:03.134701Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-27T09:47:03.134713Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.61:2380"]}
{"level":"info","ts":"2026-05-27T09:47:03.134759Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-27T09:47:03.135443Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"]}
{"level":"info","ts":"2026-05-27T09:47:03.135577Z","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.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.61:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-27T09:47:03.143575Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.361976ms"}
{"level":"info","ts":"2026-05-27T09:47:03.155369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1484a2210d3c2b8","cluster-id":"27fc2dec3fac595c"}
{"level":"info","ts":"2026-05-27T09:47:03.1555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-27T09:47:03.155533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 0"}
{"level":"info","ts":"2026-05-27T09:47:03.155551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1484a2210d3c2b8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-27T09:47:03.155562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 1"}
{"level":"info","ts":"2026-05-27T09:47:03.155613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"}
{"level":"warn","ts":"2026-05-27T09:47:03.166812Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-27T09:47:03.169629Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-27T09:47:03.17193Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-27T09:47:03.17565Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1484a2210d3c2b8","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-27T09:47:03.177193Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1484a2210d3c2b8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-27T09:47:03.177432Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-27T09:47:03.177576Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-27T09:47:03.177633Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-27T09:47:03.179708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"}
{"level":"info","ts":"2026-05-27T09:47:03.183Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","added-peer-id":"d1484a2210d3c2b8","added-peer-peer-urls":["https://199.19.213.61:2380"]}
{"level":"info","ts":"2026-05-27T09:47:03.182032Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-27T09:47:03.183344Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1484a2210d3c2b8","initial-advertise-peer-urls":["https://199.19.213.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-27T09:47:03.183645Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-27T09:47:03.182079Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.61:2380"}
{"level":"info","ts":"2026-05-27T09:47:03.183777Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.61:2380"}
{"level":"info","ts":"2026-05-27T09:47:03.256216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-27T09:47:03.256375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-27T09:47:03.256447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgPreVoteResp from d1484a2210d3c2b8 at term 1"}
{"level":"info","ts":"2026-05-27T09:47:03.256497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became candidate at term 2"}
{"level":"info","ts":"2026-05-27T09:47:03.256538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgVoteResp from d1484a2210d3c2b8 at term 2"}
{"level":"info","ts":"2026-05-27T09:47:03.256583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became leader at term 2"}
{"level":"info","ts":"2026-05-27T09:47:03.256626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1484a2210d3c2b8 elected leader d1484a2210d3c2b8 at term 2"}
{"level":"info","ts":"2026-05-27T09:47:03.265016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1484a2210d3c2b8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.61:2379]}","request-path":"/0/members/d1484a2210d3c2b8/attributes","cluster-id":"27fc2dec3fac595c","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-27T09:47:03.265058Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-27T09:47:03.265152Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T09:47:03.265473Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-27T09:47:03.2657Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-27T09:47:03.265782Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-27T09:47:03.267298Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T09:47:03.267438Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T09:47:03.267482Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T09:47:03.270001Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-27T09:47:03.270476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.61:2379"}
{"level":"info","ts":"2026-05-27T09:47:05.070184Z","caller":"traceutil/trace.go:171","msg":"trace[1326440570] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"101.124081ms","start":"2026-05-27T09:47:04.969034Z","end":"2026-05-27T09:47:05.070158Z","steps":["trace[1326440570] 'process raft request'  (duration: 100.891018ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:05.070243Z","caller":"traceutil/trace.go:171","msg":"trace[345359902] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"101.14185ms","start":"2026-05-27T09:47:04.969074Z","end":"2026-05-27T09:47:05.070216Z","steps":["trace[345359902] 'process raft request'  (duration: 100.966818ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:05.070329Z","caller":"traceutil/trace.go:171","msg":"trace[1766724996] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"101.13077ms","start":"2026-05-27T09:47:04.969153Z","end":"2026-05-27T09:47:05.070284Z","steps":["trace[1766724996] 'process raft request'  (duration: 100.986969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:05.070371Z","caller":"traceutil/trace.go:171","msg":"trace[983888629] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"100.893328ms","start":"2026-05-27T09:47:04.969435Z","end":"2026-05-27T09:47:05.070328Z","steps":["trace[983888629] 'process raft request'  (duration: 100.741956ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:05.070489Z","caller":"traceutil/trace.go:171","msg":"trace[2112622842] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"100.692825ms","start":"2026-05-27T09:47:04.969785Z","end":"2026-05-27T09:47:05.070478Z","steps":["trace[2112622842] 'process raft request'  (duration: 100.419501ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:05.070684Z","caller":"traceutil/trace.go:171","msg":"trace[913910048] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"100.735065ms","start":"2026-05-27T09:47:04.969928Z","end":"2026-05-27T09:47:05.070663Z","steps":["trace[913910048] 'read index received'  (duration: 95.859272ms)","trace[913910048] 'applied index is now lower than readState.Index'  (duration: 4.873253ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:47:05.071011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.064559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-27T09:47:05.071099Z","caller":"traceutil/trace.go:171","msg":"trace[1027159320] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"101.16014ms","start":"2026-05-27T09:47:04.969925Z","end":"2026-05-27T09:47:05.071085Z","steps":["trace[1027159320] 'agreement among raft nodes before linearized reading'  (duration: 101.016939ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:09.517483Z","caller":"traceutil/trace.go:171","msg":"trace[1144648800] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"103.090981ms","start":"2026-05-27T09:47:09.414368Z","end":"2026-05-27T09:47:09.517459Z","steps":["trace[1144648800] 'process raft request'  (duration: 102.832896ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:09.890801Z","caller":"traceutil/trace.go:171","msg":"trace[1658017306] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:313; }","duration":"369.853545ms","start":"2026-05-27T09:47:09.520925Z","end":"2026-05-27T09:47:09.890779Z","steps":["trace[1658017306] 'read index received'  (duration: 333.422828ms)","trace[1658017306] 'applied index is now lower than readState.Index'  (duration: 36.429877ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:47:09.890897Z","caller":"traceutil/trace.go:171","msg":"trace[417830979] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"376.094964ms","start":"2026-05-27T09:47:09.51479Z","end":"2026-05-27T09:47:09.890885Z","steps":["trace[417830979] 'process raft request'  (duration: 375.925972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:09.890925Z","caller":"traceutil/trace.go:171","msg":"trace[1034953084] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"375.453807ms","start":"2026-05-27T09:47:09.515466Z","end":"2026-05-27T09:47:09.89092Z","steps":["trace[1034953084] 'process raft request'  (duration: 375.291225ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:09.891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.062608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:47:09.891034Z","caller":"traceutil/trace.go:171","msg":"trace[1722580104] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:305; }","duration":"370.123679ms","start":"2026-05-27T09:47:09.520902Z","end":"2026-05-27T09:47:09.891025Z","steps":["trace[1722580104] 'agreement among raft nodes before linearized reading'  (duration: 370.048508ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:09.891069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.520889Z","time spent":"370.16411ms","remote":"127.0.0.1:50594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "}
{"level":"warn","ts":"2026-05-27T09:47:09.891322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.514775Z","time spent":"376.152336ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3911 >> failure:<>"}
{"level":"info","ts":"2026-05-27T09:47:09.891387Z","caller":"traceutil/trace.go:171","msg":"trace[985546141] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"376.866996ms","start":"2026-05-27T09:47:09.514509Z","end":"2026-05-27T09:47:09.891376Z","steps":["trace[985546141] 'process raft request'  (duration: 339.71682ms)","trace[985546141] 'compare'  (duration: 36.437477ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:47:09.890902Z","caller":"traceutil/trace.go:171","msg":"trace[1648310082] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"375.712281ms","start":"2026-05-27T09:47:09.515182Z","end":"2026-05-27T09:47:09.890894Z","steps":["trace[1648310082] 'process raft request'  (duration: 375.553759ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:09.891444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.514494Z","time spent":"376.925726ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5819 >> failure:<>"}
{"level":"warn","ts":"2026-05-27T09:47:09.891488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.51517Z","time spent":"376.294578ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-05-27T09:47:09.891569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.515457Z","time spent":"375.487907ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"info","ts":"2026-05-27T09:47:10.075151Z","caller":"traceutil/trace.go:171","msg":"trace[1625094626] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"184.263938ms","start":"2026-05-27T09:47:09.890867Z","end":"2026-05-27T09:47:10.075131Z","steps":["trace[1625094626] 'read index received'  (duration: 184.097316ms)","trace[1625094626] 'applied index is now lower than readState.Index'  (duration: 165.452µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:47:10.075192Z","caller":"traceutil/trace.go:171","msg":"trace[1144609553] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"521.173631ms","start":"2026-05-27T09:47:09.553998Z","end":"2026-05-27T09:47:10.075172Z","steps":["trace[1144609553] 'process raft request'  (duration: 520.983059ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:10.075287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.214338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:47:10.075311Z","caller":"traceutil/trace.go:171","msg":"trace[846249730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:306; }","duration":"466.286149ms","start":"2026-05-27T09:47:09.609017Z","end":"2026-05-27T09:47:10.075304Z","steps":["trace[846249730] 'agreement among raft nodes before linearized reading'  (duration: 466.222718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:10.075337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.608994Z","time spent":"466.338199ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-27T09:47:10.075438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:09.553981Z","time spent":"521.248342ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:288 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7029 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-05-27T09:47:10.075576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.805236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-05-27T09:47:10.075643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.847286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"}
{"level":"warn","ts":"2026-05-27T09:47:10.075649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.861006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7102"}
{"level":"info","ts":"2026-05-27T09:47:10.075671Z","caller":"traceutil/trace.go:171","msg":"trace[702385794] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:306; }","duration":"181.891126ms","start":"2026-05-27T09:47:09.893774Z","end":"2026-05-27T09:47:10.075665Z","steps":["trace[702385794] 'agreement among raft nodes before linearized reading'  (duration: 181.859406ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:10.07567Z","caller":"traceutil/trace.go:171","msg":"trace[1765034105] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:306; }","duration":"181.891336ms","start":"2026-05-27T09:47:09.89377Z","end":"2026-05-27T09:47:10.075661Z","steps":["trace[1765034105] 'agreement among raft nodes before linearized reading'  (duration: 181.844646ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:10.075664Z","caller":"traceutil/trace.go:171","msg":"trace[1794213166] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:306; }","duration":"181.928787ms","start":"2026-05-27T09:47:09.893714Z","end":"2026-05-27T09:47:10.075643Z","steps":["trace[1794213166] 'agreement among raft nodes before linearized reading'  (duration: 181.789555ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:10.075612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.799846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"}
{"level":"info","ts":"2026-05-27T09:47:10.075736Z","caller":"traceutil/trace.go:171","msg":"trace[1030433583] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:306; }","duration":"181.934067ms","start":"2026-05-27T09:47:09.893796Z","end":"2026-05-27T09:47:10.075731Z","steps":["trace[1030433583] 'agreement among raft nodes before linearized reading'  (duration: 181.787095ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:10.075727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.868457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"}
{"level":"info","ts":"2026-05-27T09:47:10.075805Z","caller":"traceutil/trace.go:171","msg":"trace[1866550400] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:306; }","duration":"181.984318ms","start":"2026-05-27T09:47:09.893803Z","end":"2026-05-27T09:47:10.075788Z","steps":["trace[1866550400] 'agreement among raft nodes before linearized reading'  (duration: 181.804446ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.434Z","caller":"traceutil/trace.go:171","msg":"trace[892113257] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"111.500797ms","start":"2026-05-27T09:47:39.322292Z","end":"2026-05-27T09:47:39.433793Z","steps":["trace[892113257] 'process raft request'  (duration: 106.603648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.439958Z","caller":"traceutil/trace.go:171","msg":"trace[1056717738] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"109.584664ms","start":"2026-05-27T09:47:39.330349Z","end":"2026-05-27T09:47:39.439934Z","steps":["trace[1056717738] 'process raft request'  (duration: 109.420332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.440171Z","caller":"traceutil/trace.go:171","msg":"trace[833396622] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"109.708256ms","start":"2026-05-27T09:47:39.330445Z","end":"2026-05-27T09:47:39.440153Z","steps":["trace[833396622] 'process raft request'  (duration: 109.435643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.440151Z","caller":"traceutil/trace.go:171","msg":"trace[2021298778] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"104.402022ms","start":"2026-05-27T09:47:39.33572Z","end":"2026-05-27T09:47:39.440122Z","steps":["trace[2021298778] 'process raft request'  (duration: 104.313251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.44034Z","caller":"traceutil/trace.go:171","msg":"trace[974976803] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"104.443952ms","start":"2026-05-27T09:47:39.335885Z","end":"2026-05-27T09:47:39.440329Z","steps":["trace[974976803] 'process raft request'  (duration: 104.200149ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.44033Z","caller":"traceutil/trace.go:171","msg":"trace[659310137] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"102.079953ms","start":"2026-05-27T09:47:39.338211Z","end":"2026-05-27T09:47:39.440291Z","steps":["trace[659310137] 'process raft request'  (duration: 101.89612ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.440437Z","caller":"traceutil/trace.go:171","msg":"trace[492408814] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"102.111613ms","start":"2026-05-27T09:47:39.338314Z","end":"2026-05-27T09:47:39.440425Z","steps":["trace[492408814] 'process raft request'  (duration: 101.82819ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:39.440436Z","caller":"traceutil/trace.go:171","msg":"trace[1122952719] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:546; }","duration":"109.685916ms","start":"2026-05-27T09:47:39.330704Z","end":"2026-05-27T09:47:39.44039Z","steps":["trace[1122952719] 'read index received'  (duration: 98.275127ms)","trace[1122952719] 'applied index is now lower than readState.Index'  (duration: 11.409909ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:47:39.44022Z","caller":"traceutil/trace.go:171","msg":"trace[1256090675] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"104.31807ms","start":"2026-05-27T09:47:39.335864Z","end":"2026-05-27T09:47:39.440182Z","steps":["trace[1256090675] 'process raft request'  (duration: 104.200939ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:39.440574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.853548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-27T09:47:39.440605Z","caller":"traceutil/trace.go:171","msg":"trace[307249750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"109.937099ms","start":"2026-05-27T09:47:39.330661Z","end":"2026-05-27T09:47:39.440598Z","steps":["trace[307249750] 'agreement among raft nodes before linearized reading'  (duration: 109.824908ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:46.004028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.728423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qfmh5\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-27T09:47:46.004102Z","caller":"traceutil/trace.go:171","msg":"trace[625205771] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qfmh5; range_end:; response_count:1; response_revision:631; }","duration":"392.863026ms","start":"2026-05-27T09:47:45.611222Z","end":"2026-05-27T09:47:46.004085Z","steps":["trace[625205771] 'range keys from in-memory index tree'  (duration: 392.553157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:47:46.004132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:47:45.611199Z","time spent":"392.926309ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-qfmh5\" "}
{"level":"info","ts":"2026-05-27T09:47:46.019655Z","caller":"traceutil/trace.go:171","msg":"trace[493886984] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"181.867622ms","start":"2026-05-27T09:47:45.837766Z","end":"2026-05-27T09:47:46.019633Z","steps":["trace[493886984] 'process raft request'  (duration: 180.972652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:46.020246Z","caller":"traceutil/trace.go:171","msg":"trace[394929332] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"123.674438ms","start":"2026-05-27T09:47:45.89655Z","end":"2026-05-27T09:47:46.020224Z","steps":["trace[394929332] 'process raft request'  (duration: 123.529373ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:46.712112Z","caller":"traceutil/trace.go:171","msg":"trace[358458376] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"101.536122ms","start":"2026-05-27T09:47:46.610547Z","end":"2026-05-27T09:47:46.712083Z","steps":["trace[358458376] 'process raft request'  (duration: 18.229373ms)","trace[358458376] 'compare'  (duration: 82.647568ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:47:46.714049Z","caller":"traceutil/trace.go:171","msg":"trace[1266605486] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"100.076714ms","start":"2026-05-27T09:47:46.613959Z","end":"2026-05-27T09:47:46.714036Z","steps":["trace[1266605486] 'process raft request'  (duration: 97.710786ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:47:46.715435Z","caller":"traceutil/trace.go:171","msg":"trace[315521128] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"100.242609ms","start":"2026-05-27T09:47:46.615173Z","end":"2026-05-27T09:47:46.715416Z","steps":["trace[315521128] 'process raft request'  (duration: 96.566298ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:48:29.705441Z","caller":"traceutil/trace.go:171","msg":"trace[371827347] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"179.156394ms","start":"2026-05-27T09:48:29.526268Z","end":"2026-05-27T09:48:29.705425Z","steps":["trace[371827347] 'process raft request'  (duration: 179.062192ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:48:49.617336Z","caller":"traceutil/trace.go:171","msg":"trace[576327141] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"107.478635ms","start":"2026-05-27T09:48:49.509828Z","end":"2026-05-27T09:48:49.617307Z","steps":["trace[576327141] 'process raft request'  (duration: 88.790837ms)","trace[576327141] 'compare'  (duration: 18.526865ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:48:49.801408Z","caller":"traceutil/trace.go:171","msg":"trace[1228491449] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"102.580093ms","start":"2026-05-27T09:48:49.698782Z","end":"2026-05-27T09:48:49.801362Z","steps":["trace[1228491449] 'process raft request'  (duration: 58.26393ms)","trace[1228491449] 'compare'  (duration: 43.541225ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:19.039994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.633979ms","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-05-27T09:49:19.040263Z","caller":"traceutil/trace.go:171","msg":"trace[483559686] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1872; }","duration":"132.953805ms","start":"2026-05-27T09:49:18.907289Z","end":"2026-05-27T09:49:19.040242Z","steps":["trace[483559686] 'range keys from in-memory index tree'  (duration: 132.616869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:19.040719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.46523ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14031138812153201111 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1721 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T09:49:19.041004Z","caller":"traceutil/trace.go:171","msg":"trace[1071807940] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"304.032396ms","start":"2026-05-27T09:49:18.736935Z","end":"2026-05-27T09:49:19.040968Z","steps":["trace[1071807940] 'process raft request'  (duration: 65.060077ms)","trace[1071807940] 'compare'  (duration: 238.155424ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:49:19.040997Z","caller":"traceutil/trace.go:171","msg":"trace[1178885422] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"293.900146ms","start":"2026-05-27T09:49:18.747075Z","end":"2026-05-27T09:49:19.040975Z","steps":["trace[1178885422] 'read index received'  (duration: 55.011799ms)","trace[1178885422] 'applied index is now lower than readState.Index'  (duration: 238.772195ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:19.041203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:18.736917Z","time spent":"304.166218ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1721 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-27T09:49:19.041283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.180462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-27T09:49:19.04138Z","caller":"traceutil/trace.go:171","msg":"trace[1124230361] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"294.387595ms","start":"2026-05-27T09:49:18.746968Z","end":"2026-05-27T09:49:19.041356Z","steps":["trace[1124230361] 'agreement among raft nodes before linearized reading'  (duration: 294.150531ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:19.041439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.840532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-27T09:49:19.041548Z","caller":"traceutil/trace.go:171","msg":"trace[1056142160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1873; }","duration":"272.994075ms","start":"2026-05-27T09:49:18.768527Z","end":"2026-05-27T09:49:19.041521Z","steps":["trace[1056142160] 'agreement among raft nodes before linearized reading'  (duration: 272.654239ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:19.04163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.589049ms","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-05-27T09:49:19.041666Z","caller":"traceutil/trace.go:171","msg":"trace[269110733] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1873; }","duration":"248.653721ms","start":"2026-05-27T09:49:18.793003Z","end":"2026-05-27T09:49:19.041657Z","steps":["trace[269110733] 'agreement among raft nodes before linearized reading'  (duration: 248.60902ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:19.041566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.364237ms","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-05-27T09:49:19.041966Z","caller":"traceutil/trace.go:171","msg":"trace[2130092076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1873; }","duration":"161.818125ms","start":"2026-05-27T09:49:18.880129Z","end":"2026-05-27T09:49:19.041948Z","steps":["trace[2130092076] 'agreement among raft nodes before linearized reading'  (duration: 161.380826ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:19.385033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.402939ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14031138812153201118 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" mod_revision:1825 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" value_size:3628 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T09:49:19.385132Z","caller":"traceutil/trace.go:171","msg":"trace[240233016] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1946; }","duration":"148.003459ms","start":"2026-05-27T09:49:19.237114Z","end":"2026-05-27T09:49:19.385117Z","steps":["trace[240233016] 'read index received'  (duration: 75.671µs)","trace[240233016] 'applied index is now lower than readState.Index'  (duration: 147.926588ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:19.385259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.412994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:49:19.385305Z","caller":"traceutil/trace.go:171","msg":"trace[1908028825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1876; }","duration":"106.551336ms","start":"2026-05-27T09:49:19.278738Z","end":"2026-05-27T09:49:19.385289Z","steps":["trace[1908028825] 'agreement among raft nodes before linearized reading'  (duration: 106.465645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:49:19.385309Z","caller":"traceutil/trace.go:171","msg":"trace[861920110] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"304.129949ms","start":"2026-05-27T09:49:19.08116Z","end":"2026-05-27T09:49:19.38529Z","steps":["trace[861920110] 'process raft request'  (duration: 135.384074ms)","trace[861920110] 'compare'  (duration: 168.173875ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:19.385398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:19.081144Z","time spent":"304.2067ms","remote":"127.0.0.1:50578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" mod_revision:1825 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" value_size:3628 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02052d5b-6efc-4c9f-acbb-28561ab65fe9\" > >"}
{"level":"warn","ts":"2026-05-27T09:49:19.385386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.237004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-27T09:49:19.385463Z","caller":"traceutil/trace.go:171","msg":"trace[1066858870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1876; }","duration":"148.353886ms","start":"2026-05-27T09:49:19.237092Z","end":"2026-05-27T09:49:19.385446Z","steps":["trace[1066858870] 'agreement among raft nodes before linearized reading'  (duration: 148.100592ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:49:58.321431Z","caller":"traceutil/trace.go:171","msg":"trace[55059190] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"128.814094ms","start":"2026-05-27T09:49:58.192592Z","end":"2026-05-27T09:49:58.321406Z","steps":["trace[55059190] 'process raft request'  (duration: 128.651581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:49:58.32176Z","caller":"traceutil/trace.go:171","msg":"trace[1314829125] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2215; }","duration":"127.230577ms","start":"2026-05-27T09:49:58.194492Z","end":"2026-05-27T09:49:58.321723Z","steps":["trace[1314829125] 'read index received'  (duration: 127.217717ms)","trace[1314829125] 'applied index is now lower than readState.Index'  (duration: 10.64µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:58.322051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.546833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-27T09:49:58.322126Z","caller":"traceutil/trace.go:171","msg":"trace[2034422884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2135; }","duration":"127.668624ms","start":"2026-05-27T09:49:58.194434Z","end":"2026-05-27T09:49:58.322103Z","steps":["trace[2034422884] 'agreement among raft nodes before linearized reading'  (duration: 127.41629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:49:58.555582Z","caller":"traceutil/trace.go:171","msg":"trace[662623952] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2215; }","duration":"233.716631ms","start":"2026-05-27T09:49:58.321841Z","end":"2026-05-27T09:49:58.555558Z","steps":["trace[662623952] 'read index received'  (duration: 233.65342ms)","trace[662623952] 'applied index is now lower than readState.Index'  (duration: 61.961µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:58.555741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.270791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:49:58.555778Z","caller":"traceutil/trace.go:171","msg":"trace[1815048518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2136; }","duration":"278.364813ms","start":"2026-05-27T09:49:58.277404Z","end":"2026-05-27T09:49:58.555769Z","steps":["trace[1815048518] 'agreement among raft nodes before linearized reading'  (duration: 278.269302ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:49:58.555749Z","caller":"traceutil/trace.go:171","msg":"trace[2099978516] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"285.027805ms","start":"2026-05-27T09:49:58.270675Z","end":"2026-05-27T09:49:58.555703Z","steps":["trace[2099978516] 'process raft request'  (duration: 284.74007ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:58.766167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.883736ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14031138812153201722 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2125 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T09:49:58.766601Z","caller":"traceutil/trace.go:171","msg":"trace[730173795] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"438.540179ms","start":"2026-05-27T09:49:58.328028Z","end":"2026-05-27T09:49:58.766569Z","steps":["trace[730173795] 'process raft request'  (duration: 315.189356ms)","trace[730173795] 'compare'  (duration: 122.724843ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:49:58.766773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:58.327959Z","time spent":"438.717392ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2125 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-27T09:49:58.767129Z","caller":"traceutil/trace.go:171","msg":"trace[783639736] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"211.46149ms","start":"2026-05-27T09:49:58.555644Z","end":"2026-05-27T09:49:58.767106Z","steps":["trace[783639736] 'read index received'  (duration: 87.492346ms)","trace[783639736] 'applied index is now lower than readState.Index'  (duration: 123.968024ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:49:58.767128Z","caller":"traceutil/trace.go:171","msg":"trace[1277013424] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"429.327437ms","start":"2026-05-27T09:49:58.337779Z","end":"2026-05-27T09:49:58.767107Z","steps":["trace[1277013424] 'process raft request'  (duration: 428.619545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:58.767291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.634714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"warn","ts":"2026-05-27T09:49:58.767324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:58.337768Z","time spent":"429.504309ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2127 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-27T09:49:58.767377Z","caller":"traceutil/trace.go:171","msg":"trace[1137384917] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2138; }","duration":"410.736737ms","start":"2026-05-27T09:49:58.356606Z","end":"2026-05-27T09:49:58.767343Z","steps":["trace[1137384917] 'agreement among raft nodes before linearized reading'  (duration: 410.565604ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:58.767435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:58.356594Z","time spent":"410.826928ms","remote":"127.0.0.1:46718","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-05-27T09:49:58.767558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.085187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:49:58.767588Z","caller":"traceutil/trace.go:171","msg":"trace[1385095458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2138; }","duration":"210.150068ms","start":"2026-05-27T09:49:58.557427Z","end":"2026-05-27T09:49:58.767577Z","steps":["trace[1385095458] 'agreement among raft nodes before linearized reading'  (duration: 210.107298ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:58.76819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.307684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-27T09:49:58.768246Z","caller":"traceutil/trace.go:171","msg":"trace[367047097] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2138; }","duration":"367.415756ms","start":"2026-05-27T09:49:58.400809Z","end":"2026-05-27T09:49:58.768225Z","steps":["trace[367047097] 'agreement among raft nodes before linearized reading'  (duration: 366.339387ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:49:58.76828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:49:58.400773Z","time spent":"367.499478ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-27T09:49:59.081892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.744249ms","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-05-27T09:49:59.082101Z","caller":"traceutil/trace.go:171","msg":"trace[99963589] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2139; }","duration":"173.968173ms","start":"2026-05-27T09:49:58.908087Z","end":"2026-05-27T09:49:59.082055Z","steps":["trace[99963589] 'range keys from in-memory index tree'  (duration: 173.726039ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:50:48.268705Z","caller":"traceutil/trace.go:171","msg":"trace[625045205] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"106.898822ms","start":"2026-05-27T09:50:48.161746Z","end":"2026-05-27T09:50:48.268644Z","steps":["trace[625045205] 'process raft request'  (duration: 106.717549ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:51:21.399701Z","caller":"traceutil/trace.go:171","msg":"trace[1724537564] linearizableReadLoop","detail":"{readStateIndex:2793; appliedIndex:2791; }","duration":"170.563467ms","start":"2026-05-27T09:51:21.229112Z","end":"2026-05-27T09:51:21.399675Z","steps":["trace[1724537564] 'read index received'  (duration: 5.33722ms)","trace[1724537564] 'applied index is now lower than readState.Index'  (duration: 165.225087ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:51:21.399945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.82255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9281"}
{"level":"info","ts":"2026-05-27T09:51:21.399987Z","caller":"traceutil/trace.go:171","msg":"trace[2060963822] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2694; }","duration":"170.898261ms","start":"2026-05-27T09:51:21.229076Z","end":"2026-05-27T09:51:21.399974Z","steps":["trace[2060963822] 'agreement among raft nodes before linearized reading'  (duration: 170.747379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:51:21.400098Z","caller":"traceutil/trace.go:171","msg":"trace[1119834402] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"171.680304ms","start":"2026-05-27T09:51:21.228135Z","end":"2026-05-27T09:51:21.399815Z","steps":["trace[1119834402] 'process raft request'  (duration: 163.983208ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:51:21.400224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.986333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-27T09:51:21.400269Z","caller":"traceutil/trace.go:171","msg":"trace[1062937837] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2694; }","duration":"157.064605ms","start":"2026-05-27T09:51:21.243194Z","end":"2026-05-27T09:51:21.400258Z","steps":["trace[1062937837] 'agreement among raft nodes before linearized reading'  (duration: 156.998834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:51:21.400728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.067762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T09:51:21.400781Z","caller":"traceutil/trace.go:171","msg":"trace[1061613691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2694; }","duration":"122.154203ms","start":"2026-05-27T09:51:21.278612Z","end":"2026-05-27T09:51:21.400766Z","steps":["trace[1061613691] 'agreement among raft nodes before linearized reading'  (duration: 122.063362ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:51:21.750496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.25975ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14031138812153203120 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" mod_revision:2668 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" value_size:692 lease:4807766775298427240 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T09:51:21.750674Z","caller":"traceutil/trace.go:171","msg":"trace[954989910] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"342.491772ms","start":"2026-05-27T09:51:21.408164Z","end":"2026-05-27T09:51:21.750655Z","steps":["trace[954989910] 'process raft request'  (duration: 135.98866ms)","trace[954989910] 'compare'  (duration: 206.082306ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:51:21.750771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:51:21.408111Z","time spent":"342.624175ms","remote":"127.0.0.1:50484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" mod_revision:2668 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" value_size:692 lease:4807766775298427240 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18b3634c1e09adf8\" > >"}
{"level":"info","ts":"2026-05-27T09:51:21.750611Z","caller":"traceutil/trace.go:171","msg":"trace[1323887056] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2793; }","duration":"309.764095ms","start":"2026-05-27T09:51:21.440831Z","end":"2026-05-27T09:51:21.750595Z","steps":["trace[1323887056] 'read index received'  (duration: 103.304372ms)","trace[1323887056] 'applied index is now lower than readState.Index'  (duration: 206.458503ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:51:21.7512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.364733ms","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-05-27T09:51:21.75124Z","caller":"traceutil/trace.go:171","msg":"trace[2015650906] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2695; }","duration":"310.431394ms","start":"2026-05-27T09:51:21.440796Z","end":"2026-05-27T09:51:21.751228Z","steps":["trace[2015650906] 'agreement among raft nodes before linearized reading'  (duration: 310.286132ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:51:21.751274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:51:21.440781Z","time spent":"310.485755ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-05-27T09:51:21.752024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.483716ms","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-05-27T09:51:21.752064Z","caller":"traceutil/trace.go:171","msg":"trace[1486003339] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2695; }","duration":"294.553547ms","start":"2026-05-27T09:51:21.457501Z","end":"2026-05-27T09:51:21.752054Z","steps":["trace[1486003339] 'agreement among raft nodes before linearized reading'  (duration: 294.08137ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:54:55.790653Z","caller":"traceutil/trace.go:171","msg":"trace[583340632] linearizableReadLoop","detail":"{readStateIndex:4594; appliedIndex:4593; }","duration":"121.910872ms","start":"2026-05-27T09:54:55.668711Z","end":"2026-05-27T09:54:55.790622Z","steps":["trace[583340632] 'read index received'  (duration: 121.440692ms)","trace[583340632] 'applied index is now lower than readState.Index'  (duration: 468.599µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:54:55.790931Z","caller":"traceutil/trace.go:171","msg":"trace[812057855] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"126.143451ms","start":"2026-05-27T09:54:55.664745Z","end":"2026-05-27T09:54:55.790889Z","steps":["trace[812057855] 'process raft request'  (duration: 125.508058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:54:55.791143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.37747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7464"}
{"level":"info","ts":"2026-05-27T09:54:55.791232Z","caller":"traceutil/trace.go:171","msg":"trace[2039543639] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4428; }","duration":"122.525153ms","start":"2026-05-27T09:54:55.668654Z","end":"2026-05-27T09:54:55.791179Z","steps":["trace[2039543639] 'agreement among raft nodes before linearized reading'  (duration: 122.222727ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:00.045424Z","caller":"traceutil/trace.go:171","msg":"trace[696663263] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"125.810022ms","start":"2026-05-27T09:54:59.919591Z","end":"2026-05-27T09:55:00.045401Z","steps":["trace[696663263] 'process raft request'  (duration: 125.70159ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:00.045789Z","caller":"traceutil/trace.go:171","msg":"trace[674211109] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"126.051686ms","start":"2026-05-27T09:54:59.919718Z","end":"2026-05-27T09:55:00.04577Z","steps":["trace[674211109] 'process raft request'  (duration: 125.629128ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:00.045441Z","caller":"traceutil/trace.go:171","msg":"trace[1617881166] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"129.44817ms","start":"2026-05-27T09:54:59.915964Z","end":"2026-05-27T09:55:00.045412Z","steps":["trace[1617881166] 'process raft request'  (duration: 129.189335ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:00.045912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.08703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-27T09:55:00.045947Z","caller":"traceutil/trace.go:171","msg":"trace[336621101] 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:4541; }","duration":"123.299475ms","start":"2026-05-27T09:54:59.922637Z","end":"2026-05-27T09:55:00.045936Z","steps":["trace[336621101] 'agreement among raft nodes before linearized reading'  (duration: 122.990008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:00.045612Z","caller":"traceutil/trace.go:171","msg":"trace[1577655219] linearizableReadLoop","detail":"{readStateIndex:4714; appliedIndex:4711; }","duration":"122.955347ms","start":"2026-05-27T09:54:59.922645Z","end":"2026-05-27T09:55:00.0456Z","steps":["trace[1577655219] 'read index received'  (duration: 17.846383ms)","trace[1577655219] 'applied index is now lower than readState.Index'  (duration: 105.107594ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:55:06.073912Z","caller":"traceutil/trace.go:171","msg":"trace[1700224315] linearizableReadLoop","detail":"{readStateIndex:4794; appliedIndex:4793; }","duration":"259.802091ms","start":"2026-05-27T09:55:05.814082Z","end":"2026-05-27T09:55:06.073884Z","steps":["trace[1700224315] 'read index received'  (duration: 240.518413ms)","trace[1700224315] 'applied index is now lower than readState.Index'  (duration: 19.282678ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:55:06.074007Z","caller":"traceutil/trace.go:171","msg":"trace[1909723662] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"259.927883ms","start":"2026-05-27T09:55:05.814045Z","end":"2026-05-27T09:55:06.073973Z","steps":["trace[1909723662] 'process raft request'  (duration: 240.570975ms)","trace[1909723662] 'compare'  (duration: 19.169005ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:55:06.07472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.617366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60099"}
{"level":"info","ts":"2026-05-27T09:55:06.074772Z","caller":"traceutil/trace.go:171","msg":"trace[1575810873] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4620; }","duration":"260.719139ms","start":"2026-05-27T09:55:05.814041Z","end":"2026-05-27T09:55:06.07476Z","steps":["trace[1575810873] 'agreement among raft nodes before linearized reading'  (duration: 259.957314ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.087357Z","caller":"traceutil/trace.go:171","msg":"trace[802709761] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"273.250611ms","start":"2026-05-27T09:55:05.814095Z","end":"2026-05-27T09:55:06.087345Z","steps":["trace[802709761] 'process raft request'  (duration: 272.982336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.087557Z","caller":"traceutil/trace.go:171","msg":"trace[1781387731] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"273.368972ms","start":"2026-05-27T09:55:05.814181Z","end":"2026-05-27T09:55:06.08755Z","steps":["trace[1781387731] 'process raft request'  (duration: 272.968725ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.087774Z","caller":"traceutil/trace.go:171","msg":"trace[1623969350] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"273.586356ms","start":"2026-05-27T09:55:05.814181Z","end":"2026-05-27T09:55:06.087767Z","steps":["trace[1623969350] 'process raft request'  (duration: 273.005816ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.08789Z","caller":"traceutil/trace.go:171","msg":"trace[1310523874] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"273.702949ms","start":"2026-05-27T09:55:05.814181Z","end":"2026-05-27T09:55:06.087884Z","steps":["trace[1310523874] 'process raft request'  (duration: 273.036576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.088053Z","caller":"traceutil/trace.go:171","msg":"trace[1812859127] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"161.364553ms","start":"2026-05-27T09:55:05.926682Z","end":"2026-05-27T09:55:06.088047Z","steps":["trace[1812859127] 'process raft request'  (duration: 160.562689ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.089421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.292432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-27T09:55:06.089479Z","caller":"traceutil/trace.go:171","msg":"trace[1879560130] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4625; }","duration":"273.381354ms","start":"2026-05-27T09:55:05.816083Z","end":"2026-05-27T09:55:06.089464Z","steps":["trace[1879560130] 'agreement among raft nodes before linearized reading'  (duration: 273.236882ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.08962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.193571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-05-27T09:55:06.089681Z","caller":"traceutil/trace.go:171","msg":"trace[722897133] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4625; }","duration":"273.281132ms","start":"2026-05-27T09:55:05.816386Z","end":"2026-05-27T09:55:06.089667Z","steps":["trace[722897133] 'agreement among raft nodes before linearized reading'  (duration: 273.076718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.652008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.146174ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14031138812153207897 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" mod_revision:4639 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" value_size:3153 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T09:55:06.652125Z","caller":"traceutil/trace.go:171","msg":"trace[1765688043] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"280.263147ms","start":"2026-05-27T09:55:06.371843Z","end":"2026-05-27T09:55:06.652106Z","steps":["trace[1765688043] 'process raft request'  (duration: 67.917759ms)","trace[1765688043] 'compare'  (duration: 212.021422ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:55:06.653668Z","caller":"traceutil/trace.go:171","msg":"trace[107241290] linearizableReadLoop","detail":"{readStateIndex:4820; appliedIndex:4817; }","duration":"244.953082ms","start":"2026-05-27T09:55:06.408694Z","end":"2026-05-27T09:55:06.653647Z","steps":["trace[107241290] 'read index received'  (duration: 31.074926ms)","trace[107241290] 'applied index is now lower than readState.Index'  (duration: 213.877276ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:55:06.653917Z","caller":"traceutil/trace.go:171","msg":"trace[361751157] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"250.194329ms","start":"2026-05-27T09:55:06.403706Z","end":"2026-05-27T09:55:06.6539Z","steps":["trace[361751157] 'process raft request'  (duration: 249.796012ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.654173Z","caller":"traceutil/trace.go:171","msg":"trace[338693546] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"249.731491ms","start":"2026-05-27T09:55:06.40441Z","end":"2026-05-27T09:55:06.654141Z","steps":["trace[338693546] 'process raft request'  (duration: 249.190611ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.654347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.260902ms","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-05-27T09:55:06.654414Z","caller":"traceutil/trace.go:171","msg":"trace[1003460852] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4646; }","duration":"222.358064ms","start":"2026-05-27T09:55:06.432042Z","end":"2026-05-27T09:55:06.6544Z","steps":["trace[1003460852] 'agreement among raft nodes before linearized reading'  (duration: 222.111519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.65469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.969991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9316"}
{"level":"info","ts":"2026-05-27T09:55:06.654768Z","caller":"traceutil/trace.go:171","msg":"trace[741708224] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4646; }","duration":"246.083534ms","start":"2026-05-27T09:55:06.408666Z","end":"2026-05-27T09:55:06.654749Z","steps":["trace[741708224] 'agreement among raft nodes before linearized reading'  (duration: 245.820179ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.656458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.143408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"}
{"level":"info","ts":"2026-05-27T09:55:06.657191Z","caller":"traceutil/trace.go:171","msg":"trace[1178732099] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4646; }","duration":"133.514895ms","start":"2026-05-27T09:55:06.523023Z","end":"2026-05-27T09:55:06.656538Z","steps":["trace[1178732099] 'agreement among raft nodes before linearized reading'  (duration: 131.542439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.819575Z","caller":"traceutil/trace.go:171","msg":"trace[627904509] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"119.161979ms","start":"2026-05-27T09:55:06.700376Z","end":"2026-05-27T09:55:06.819538Z","steps":["trace[627904509] 'process raft request'  (duration: 51.307781ms)","trace[627904509] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b363866a15efd8; req_size:994; } (duration: 67.491531ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T09:55:06.819721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.534129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"}
{"level":"info","ts":"2026-05-27T09:55:06.819814Z","caller":"traceutil/trace.go:171","msg":"trace[1813745306] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4652; }","duration":"117.646951ms","start":"2026-05-27T09:55:06.702153Z","end":"2026-05-27T09:55:06.8198Z","steps":["trace[1813745306] 'agreement among raft nodes before linearized reading'  (duration: 117.426196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:06.820184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.672651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9425"}
{"level":"info","ts":"2026-05-27T09:55:06.820226Z","caller":"traceutil/trace.go:171","msg":"trace[689470197] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4652; }","duration":"118.716242ms","start":"2026-05-27T09:55:06.7015Z","end":"2026-05-27T09:55:06.820216Z","steps":["trace[689470197] 'agreement among raft nodes before linearized reading'  (duration: 118.61726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:06.819602Z","caller":"traceutil/trace.go:171","msg":"trace[1954604950] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"119.027207ms","start":"2026-05-27T09:55:06.700538Z","end":"2026-05-27T09:55:06.819566Z","steps":["trace[1954604950] 'process raft request'  (duration: 118.926645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:19.027271Z","caller":"traceutil/trace.go:171","msg":"trace[1283853507] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"135.857335ms","start":"2026-05-27T09:55:18.891392Z","end":"2026-05-27T09:55:19.027249Z","steps":["trace[1283853507] 'process raft request'  (duration: 135.715932ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:55:19.076594Z","caller":"traceutil/trace.go:171","msg":"trace[526051178] linearizableReadLoop","detail":"{readStateIndex:5006; appliedIndex:5004; }","duration":"113.028286ms","start":"2026-05-27T09:55:18.963551Z","end":"2026-05-27T09:55:19.07658Z","steps":["trace[526051178] 'read index received'  (duration: 63.611232ms)","trace[526051178] 'applied index is now lower than readState.Index'  (duration: 49.416414ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T09:55:19.076668Z","caller":"traceutil/trace.go:171","msg":"trace[165010426] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"164.56995ms","start":"2026-05-27T09:55:18.91209Z","end":"2026-05-27T09:55:19.07666Z","steps":["trace[165010426] 'process raft request'  (duration: 164.396537ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T09:55:19.077593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.018154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-05-27T09:55:19.077699Z","caller":"traceutil/trace.go:171","msg":"trace[849994398] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4827; }","duration":"114.161846ms","start":"2026-05-27T09:55:18.963509Z","end":"2026-05-27T09:55:19.077671Z","steps":["trace[849994398] 'agreement among raft nodes before linearized reading'  (duration: 113.294051ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T09:57:03.59807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2916}
{"level":"info","ts":"2026-05-27T09:57:03.682154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2916,"took":"82.513424ms","hash":721087512,"current-db-size-bytes":54226944,"current-db-size":"54 MB","current-db-size-in-use-bytes":29749248,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-27T09:57:03.682213Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":721087512,"revision":2916,"compact-revision":-1}
{"level":"info","ts":"2026-05-27T10:02:03.603643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5636}
{"level":"info","ts":"2026-05-27T10:02:03.6827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5636,"took":"77.590048ms","hash":3710848718,"current-db-size-bytes":54226944,"current-db-size":"54 MB","current-db-size-in-use-bytes":18214912,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-27T10:02:03.68277Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3710848718,"revision":5636,"compact-revision":2916}