{"level":"warn","ts":"2026-03-27T01:57:35.606942Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-27T01:57:35.607048Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-03-27T01:57:35.607122Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-27T01:57:35.607133Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-03-27T01:57:35.607152Z","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-03-27T01:57:35.607894Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-03-27T01:57:35.607967Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-03-27T01:57:35.611782Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.573209ms"} {"level":"info","ts":"2026-03-27T01:57:35.61709Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-03-27T01:57:35.617171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-03-27T01:57:35.617196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-03-27T01:57:35.617207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-27T01:57:35.61722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-03-27T01:57:35.617266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-03-27T01:57:35.623277Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-27T01:57:35.624997Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-27T01:57:35.62617Z","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-03-27T01:57:35.628686Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-27T01:57:35.628912Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-27T01:57:35.628949Z","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-03-27T01:57:35.629334Z","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-03-27T01:57:35.629572Z","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-03-27T01:57:35.630654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-03-27T01:57:35.630899Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-03-27T01:57:35.637102Z","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-03-27T01:57:35.63722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-03-27T01:57:35.637396Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-03-27T01:57:35.637541Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-27T01:57:35.637574Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-27T01:57:35.817889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-03-27T01:57:35.817943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-27T01:57:35.817981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-03-27T01:57:35.818005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-03-27T01:57:35.818016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-03-27T01:57:35.818033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-03-27T01:57:35.818059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-03-27T01:57:35.819511Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-03-27T01:57:35.819604Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-27T01:57:35.819636Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-27T01:57:35.819662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-27T01:57:35.820009Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-27T01:57:35.820094Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-27T01:57:35.820557Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-03-27T01:57:35.820662Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-27T01:57:35.820695Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-27T01:57:35.82183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-03-27T01:57:35.824047Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-27T01:58:04.740445Z","caller":"traceutil/trace.go:171","msg":"trace[1144324597] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"150.898152ms","start":"2026-03-27T01:58:04.589519Z","end":"2026-03-27T01:58:04.740417Z","steps":["trace[1144324597] 'process raft request' (duration: 113.012937ms)","trace[1144324597] 'compare' (duration: 37.764912ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T01:58:04.792728Z","caller":"traceutil/trace.go:171","msg":"trace[748848718] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"200.63541ms","start":"2026-03-27T01:58:04.592057Z","end":"2026-03-27T01:58:04.792692Z","steps":["trace[748848718] 'process raft request' (duration: 200.346513ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:04.793641Z","caller":"traceutil/trace.go:171","msg":"trace[1246663304] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"189.090475ms","start":"2026-03-27T01:58:04.604509Z","end":"2026-03-27T01:58:04.793599Z","steps":["trace[1246663304] 'process raft request' (duration: 188.340745ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:58:04.793778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.093174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-03-27T01:58:04.79389Z","caller":"traceutil/trace.go:171","msg":"trace[1985699921] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:501; }","duration":"198.248968ms","start":"2026-03-27T01:58:04.595623Z","end":"2026-03-27T01:58:04.793871Z","steps":["trace[1985699921] 'agreement among raft nodes before linearized reading' (duration: 198.052133ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:04.793567Z","caller":"traceutil/trace.go:171","msg":"trace[1387323399] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"197.875408ms","start":"2026-03-27T01:58:04.595659Z","end":"2026-03-27T01:58:04.793534Z","steps":["trace[1387323399] 'read index received' (duration: 106.902635ms)","trace[1387323399] 'applied index is now lower than readState.Index' (duration: 90.971263ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T01:58:04.799505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.679091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-03-27T01:58:04.799577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.591058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-03-27T01:58:04.799855Z","caller":"traceutil/trace.go:171","msg":"trace[1329440483] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:501; }","duration":"100.926737ms","start":"2026-03-27T01:58:04.698902Z","end":"2026-03-27T01:58:04.799829Z","steps":["trace[1329440483] 'agreement among raft nodes before linearized reading' (duration: 100.466035ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:04.79967Z","caller":"traceutil/trace.go:171","msg":"trace[14738323] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:501; }","duration":"100.789883ms","start":"2026-03-27T01:58:04.698787Z","end":"2026-03-27T01:58:04.799577Z","steps":["trace[14738323] 'agreement among raft nodes before linearized reading' (duration: 100.559397ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:06.920268Z","caller":"traceutil/trace.go:171","msg":"trace[1002901041] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"263.509199ms","start":"2026-03-27T01:58:06.656721Z","end":"2026-03-27T01:58:06.92023Z","steps":["trace[1002901041] 'process raft request' (duration: 263.19583ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:06.92595Z","caller":"traceutil/trace.go:171","msg":"trace[49988540] transaction","detail":"{read_only:false; number_of_response:1; response_revision:558; }","duration":"266.278151ms","start":"2026-03-27T01:58:06.659635Z","end":"2026-03-27T01:58:06.925913Z","steps":["trace[49988540] 'process raft request' (duration: 265.884931ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:06.92632Z","caller":"traceutil/trace.go:171","msg":"trace[1428201560] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"197.913339ms","start":"2026-03-27T01:58:06.72839Z","end":"2026-03-27T01:58:06.926303Z","steps":["trace[1428201560] 'process raft request' (duration: 197.472217ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:58:12.70563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.923287ms","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-03-27T01:58:12.705832Z","caller":"traceutil/trace.go:171","msg":"trace[1615952571] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:612; }","duration":"160.151843ms","start":"2026-03-27T01:58:12.545647Z","end":"2026-03-27T01:58:12.705799Z","steps":["trace[1615952571] 'range keys from in-memory index tree' (duration: 159.853015ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:58:12.706153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.539387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-27T01:58:12.706289Z","caller":"traceutil/trace.go:171","msg":"trace[540141064] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"215.581236ms","start":"2026-03-27T01:58:12.490689Z","end":"2026-03-27T01:58:12.70627Z","steps":["trace[540141064] 'read index received' (duration: 65.31238ms)","trace[540141064] 'applied index is now lower than readState.Index' (duration: 150.267396ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T01:58:12.706327Z","caller":"traceutil/trace.go:171","msg":"trace[1524567813] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"386.454378ms","start":"2026-03-27T01:58:12.319819Z","end":"2026-03-27T01:58:12.706274Z","steps":["trace[1524567813] 'process raft request' (duration: 236.221803ms)","trace[1524567813] 'compare' (duration: 149.350112ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T01:58:12.706447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.760512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-27T01:58:12.706467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.578946ms","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-03-27T01:58:12.706498Z","caller":"traceutil/trace.go:171","msg":"trace[364951997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"215.863144ms","start":"2026-03-27T01:58:12.490618Z","end":"2026-03-27T01:58:12.706481Z","steps":["trace[364951997] 'agreement among raft nodes before linearized reading' (duration: 215.733321ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:58:12.706508Z","caller":"traceutil/trace.go:171","msg":"trace[1917322644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"192.663688ms","start":"2026-03-27T01:58:12.513833Z","end":"2026-03-27T01:58:12.706497Z","steps":["trace[1917322644] 'agreement among raft nodes before linearized reading' (duration: 192.563166ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:58:12.706532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-27T01:58:12.319794Z","time spent":"386.641153ms","remote":"127.0.0.1:47708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-27T01:58:12.706586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.04809ms","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-03-27T01:58:12.706688Z","caller":"traceutil/trace.go:171","msg":"trace[1696903880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"121.230355ms","start":"2026-03-27T01:58:12.585438Z","end":"2026-03-27T01:58:12.706668Z","steps":["trace[1696903880] 'agreement among raft nodes before linearized reading' (duration: 120.985998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:58:12.706655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.768643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2wt54\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-27T01:58:12.706765Z","caller":"traceutil/trace.go:171","msg":"trace[1545020756] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2wt54; range_end:; response_count:1; response_revision:613; }","duration":"146.912608ms","start":"2026-03-27T01:58:12.559827Z","end":"2026-03-27T01:58:12.70674Z","steps":["trace[1545020756] 'agreement among raft nodes before linearized reading' (duration: 146.628919ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.302975Z","caller":"traceutil/trace.go:171","msg":"trace[1579481443] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"353.661882ms","start":"2026-03-27T01:59:54.949278Z","end":"2026-03-27T01:59:55.30294Z","steps":["trace[1579481443] 'process raft request' (duration: 324.958388ms)","trace[1579481443] 'compare' (duration: 28.264752ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T01:59:55.30297Z","caller":"traceutil/trace.go:171","msg":"trace[1194418415] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"272.116899ms","start":"2026-03-27T01:59:55.030819Z","end":"2026-03-27T01:59:55.302935Z","steps":["trace[1194418415] 'read index received' (duration: 243.417725ms)","trace[1194418415] 'applied index is now lower than readState.Index' (duration: 28.697514ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T01:59:55.303208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.365996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-06dc8831-f643-4fc2-aa13-37822a46bcb9\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-03-27T01:59:55.303325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-27T01:59:54.949249Z","time spent":"353.807645ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-27T01:59:55.303329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.022799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10630"} {"level":"info","ts":"2026-03-27T01:59:55.303374Z","caller":"traceutil/trace.go:171","msg":"trace[1872602152] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1869; }","duration":"206.169343ms","start":"2026-03-27T01:59:55.097188Z","end":"2026-03-27T01:59:55.303357Z","steps":["trace[1872602152] 'agreement among raft nodes before linearized reading' (duration: 205.988988ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.303829Z","caller":"traceutil/trace.go:171","msg":"trace[760153425] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-06dc8831-f643-4fc2-aa13-37822a46bcb9; range_end:; response_count:1; response_revision:1869; }","duration":"273.027723ms","start":"2026-03-27T01:59:55.030782Z","end":"2026-03-27T01:59:55.30381Z","steps":["trace[760153425] 'agreement among raft nodes before linearized reading' (duration: 272.217971ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.47811Z","caller":"traceutil/trace.go:171","msg":"trace[1027952534] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"100.525037ms","start":"2026-03-27T01:59:55.377554Z","end":"2026-03-27T01:59:55.478079Z","steps":["trace[1027952534] 'process raft request' (duration: 57.981724ms)","trace[1027952534] 'compare' (duration: 42.385879ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T01:59:55.48765Z","caller":"traceutil/trace.go:171","msg":"trace[2041664699] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"109.092006ms","start":"2026-03-27T01:59:55.378532Z","end":"2026-03-27T01:59:55.487624Z","steps":["trace[2041664699] 'process raft request' (duration: 108.84297ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.487895Z","caller":"traceutil/trace.go:171","msg":"trace[955358760] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"108.902782ms","start":"2026-03-27T01:59:55.378969Z","end":"2026-03-27T01:59:55.487871Z","steps":["trace[955358760] 'process raft request' (duration: 108.582013ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.488032Z","caller":"traceutil/trace.go:171","msg":"trace[393459370] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1945; }","duration":"109.152978ms","start":"2026-03-27T01:59:55.378862Z","end":"2026-03-27T01:59:55.488015Z","steps":["trace[393459370] 'read index received' (duration: 56.764932ms)","trace[393459370] 'applied index is now lower than readState.Index' (duration: 52.386576ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T01:59:55.488139Z","caller":"traceutil/trace.go:171","msg":"trace[633113096] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"103.820276ms","start":"2026-03-27T01:59:55.384306Z","end":"2026-03-27T01:59:55.488126Z","steps":["trace[633113096] 'process raft request' (duration: 103.654672ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.488092Z","caller":"traceutil/trace.go:171","msg":"trace[1572871596] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"108.942523ms","start":"2026-03-27T01:59:55.379101Z","end":"2026-03-27T01:59:55.488043Z","steps":["trace[1572871596] 'process raft request' (duration: 108.698037ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T01:59:55.488161Z","caller":"traceutil/trace.go:171","msg":"trace[1088095656] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"108.490741ms","start":"2026-03-27T01:59:55.379615Z","end":"2026-03-27T01:59:55.488105Z","steps":["trace[1088095656] 'process raft request' (duration: 108.291116ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:59:55.488272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.380424ms","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-03-27T01:59:55.488319Z","caller":"traceutil/trace.go:171","msg":"trace[1203986909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1876; }","duration":"109.465606ms","start":"2026-03-27T01:59:55.378841Z","end":"2026-03-27T01:59:55.488307Z","steps":["trace[1203986909] 'agreement among raft nodes before linearized reading' (duration: 109.287681ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T01:59:55.488337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.337189ms","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-03-27T01:59:55.4884Z","caller":"traceutil/trace.go:171","msg":"trace[1218755873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1876; }","duration":"107.432402ms","start":"2026-03-27T01:59:55.380952Z","end":"2026-03-27T01:59:55.488384Z","steps":["trace[1218755873] 'agreement among raft nodes before linearized reading' (duration: 107.258988ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:00:12.617585Z","caller":"traceutil/trace.go:171","msg":"trace[669825730] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"123.891381ms","start":"2026-03-27T02:00:12.49367Z","end":"2026-03-27T02:00:12.617562Z","steps":["trace[669825730] 'process raft request' (duration: 123.526582ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:00:45.391343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.152182ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-27T02:00:45.392105Z","caller":"traceutil/trace.go:171","msg":"trace[269409547] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"475.161058ms","start":"2026-03-27T02:00:44.91691Z","end":"2026-03-27T02:00:45.392071Z","steps":["trace[269409547] 'process raft request' (duration: 474.668475ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:00:45.392161Z","caller":"traceutil/trace.go:171","msg":"trace[1898363208] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2276; }","duration":"396.542771ms","start":"2026-03-27T02:00:44.99558Z","end":"2026-03-27T02:00:45.392123Z","steps":["trace[1898363208] 'read index received' (duration: 8.602029ms)","trace[1898363208] 'applied index is now lower than readState.Index' (duration: 387.937442ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T02:00:45.392352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-27T02:00:44.91689Z","time spent":"475.335143ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-27T02:00:45.392462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.864319ms","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-03-27T02:00:45.392564Z","caller":"traceutil/trace.go:171","msg":"trace[1439103799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2191; }","duration":"397.024955ms","start":"2026-03-27T02:00:44.995514Z","end":"2026-03-27T02:00:45.392539Z","steps":["trace[1439103799] 'agreement among raft nodes before linearized reading' (duration: 396.711447ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:00:45.39261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-27T02:00:44.995489Z","time spent":"397.111927ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-27T02:00:45.393104Z","caller":"traceutil/trace.go:171","msg":"trace[1300279466] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"244.090537ms","start":"2026-03-27T02:00:45.148997Z","end":"2026-03-27T02:00:45.393088Z","steps":["trace[1300279466] 'process raft request' (duration: 243.631595ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:00:45.393189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.258607ms","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-03-27T02:00:45.393327Z","caller":"traceutil/trace.go:171","msg":"trace[931268689] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2192; }","duration":"300.456212ms","start":"2026-03-27T02:00:45.092834Z","end":"2026-03-27T02:00:45.39329Z","steps":["trace[931268689] 'agreement among raft nodes before linearized reading' (duration: 300.071092ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:00:45.393402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-27T02:00:45.092814Z","time spent":"300.567385ms","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-03-27T02:01:41.950331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.746749ms","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-03-27T02:01:41.95044Z","caller":"traceutil/trace.go:171","msg":"trace[440842687] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2668; }","duration":"121.892562ms","start":"2026-03-27T02:01:41.828521Z","end":"2026-03-27T02:01:41.950414Z","steps":["trace[440842687] 'count revisions from in-memory index tree' (duration: 121.678007ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:02:15.488396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.770832ms","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-03-27T02:02:15.48852Z","caller":"traceutil/trace.go:171","msg":"trace[1452021246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2870; }","duration":"216.982407ms","start":"2026-03-27T02:02:15.27151Z","end":"2026-03-27T02:02:15.488492Z","steps":["trace[1452021246] 'range keys from in-memory index tree' (duration: 216.554286ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:18.966816Z","caller":"traceutil/trace.go:171","msg":"trace[1050892163] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"149.857775ms","start":"2026-03-27T02:06:18.816923Z","end":"2026-03-27T02:06:18.96678Z","steps":["trace[1050892163] 'process raft request' (duration: 149.462435ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:18.967148Z","caller":"traceutil/trace.go:171","msg":"trace[118088324] linearizableReadLoop","detail":"{readStateIndex:5292; appliedIndex:5290; }","duration":"126.006234ms","start":"2026-03-27T02:06:18.841114Z","end":"2026-03-27T02:06:18.96712Z","steps":["trace[118088324] 'read index received' (duration: 125.209022ms)","trace[118088324] 'applied index is now lower than readState.Index' (duration: 796.012µs)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:06:18.967319Z","caller":"traceutil/trace.go:171","msg":"trace[1172762236] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"144.916131ms","start":"2026-03-27T02:06:18.822389Z","end":"2026-03-27T02:06:18.967305Z","steps":["trace[1172762236] 'process raft request' (duration: 144.362386ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:06:18.967784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.369955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-44a36970-95b0-4601-bd5d-f2f11f972775\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-03-27T02:06:18.967848Z","caller":"traceutil/trace.go:171","msg":"trace[2104970818] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-44a36970-95b0-4601-bd5d-f2f11f972775; range_end:; response_count:1; response_revision:5096; }","duration":"189.53881ms","start":"2026-03-27T02:06:18.778292Z","end":"2026-03-27T02:06:18.967831Z","steps":["trace[2104970818] 'agreement among raft nodes before linearized reading' (duration: 189.319954ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:19.073388Z","caller":"traceutil/trace.go:171","msg":"trace[285765089] transaction","detail":"{read_only:false; response_revision:5097; number_of_response:1; }","duration":"101.024061ms","start":"2026-03-27T02:06:18.972324Z","end":"2026-03-27T02:06:19.073348Z","steps":["trace[285765089] 'process raft request' (duration: 46.006117ms)","trace[285765089] 'compare' (duration: 54.857849ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:06:19.435645Z","caller":"traceutil/trace.go:171","msg":"trace[1451300166] linearizableReadLoop","detail":"{readStateIndex:5295; appliedIndex:5293; }","duration":"152.478117ms","start":"2026-03-27T02:06:19.283142Z","end":"2026-03-27T02:06:19.43562Z","steps":["trace[1451300166] 'read index received' (duration: 11.640918ms)","trace[1451300166] 'applied index is now lower than readState.Index' (duration: 140.836139ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:06:19.435798Z","caller":"traceutil/trace.go:171","msg":"trace[2092038233] transaction","detail":"{read_only:false; response_revision:5099; number_of_response:1; }","duration":"212.138147ms","start":"2026-03-27T02:06:19.223604Z","end":"2026-03-27T02:06:19.435742Z","steps":["trace[2092038233] 'process raft request' (duration: 184.758109ms)","trace[2092038233] 'compare' (duration: 27.116601ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T02:06:19.436087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.914459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-27T02:06:19.43618Z","caller":"traceutil/trace.go:171","msg":"trace[97342611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5099; }","duration":"153.060873ms","start":"2026-03-27T02:06:19.283095Z","end":"2026-03-27T02:06:19.436156Z","steps":["trace[97342611] 'agreement among raft nodes before linearized reading' (duration: 152.679902ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:26.497916Z","caller":"traceutil/trace.go:171","msg":"trace[881217879] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"132.955253ms","start":"2026-03-27T02:06:26.364926Z","end":"2026-03-27T02:06:26.497881Z","steps":["trace[881217879] 'process raft request' (duration: 132.882231ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:26.498448Z","caller":"traceutil/trace.go:171","msg":"trace[1582275681] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"133.9097ms","start":"2026-03-27T02:06:26.364524Z","end":"2026-03-27T02:06:26.498434Z","steps":["trace[1582275681] 'process raft request' (duration: 133.025335ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:26.498759Z","caller":"traceutil/trace.go:171","msg":"trace[834312179] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"134.032203ms","start":"2026-03-27T02:06:26.364689Z","end":"2026-03-27T02:06:26.498721Z","steps":["trace[834312179] 'process raft request' (duration: 133.054296ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:29.516939Z","caller":"traceutil/trace.go:171","msg":"trace[1336011883] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"175.865657ms","start":"2026-03-27T02:06:29.34105Z","end":"2026-03-27T02:06:29.516916Z","steps":["trace[1336011883] 'process raft request' (duration: 175.169278ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:29.521539Z","caller":"traceutil/trace.go:171","msg":"trace[404292128] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"130.901067ms","start":"2026-03-27T02:06:29.390627Z","end":"2026-03-27T02:06:29.521528Z","steps":["trace[404292128] 'process raft request' (duration: 130.746663ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:29.521836Z","caller":"traceutil/trace.go:171","msg":"trace[1340524388] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"131.044561ms","start":"2026-03-27T02:06:29.390773Z","end":"2026-03-27T02:06:29.521818Z","steps":["trace[1340524388] 'process raft request' (duration: 130.676501ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:48.869252Z","caller":"traceutil/trace.go:171","msg":"trace[1582027422] linearizableReadLoop","detail":"{readStateIndex:5847; appliedIndex:5846; }","duration":"229.998571ms","start":"2026-03-27T02:06:48.639215Z","end":"2026-03-27T02:06:48.869214Z","steps":["trace[1582027422] 'read index received' (duration: 229.739815ms)","trace[1582027422] 'applied index is now lower than readState.Index' (duration: 257.186µs)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:06:48.869529Z","caller":"traceutil/trace.go:171","msg":"trace[838712723] transaction","detail":"{read_only:false; response_revision:5638; number_of_response:1; }","duration":"248.213879ms","start":"2026-03-27T02:06:48.621299Z","end":"2026-03-27T02:06:48.869513Z","steps":["trace[838712723] 'process raft request' (duration: 247.705066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:06:48.869858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.621797ms","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":"warn","ts":"2026-03-27T02:06:48.869858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.413273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-27T02:06:48.870078Z","caller":"traceutil/trace.go:171","msg":"trace[1451807041] 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:5638; }","duration":"230.805873ms","start":"2026-03-27T02:06:48.639139Z","end":"2026-03-27T02:06:48.869944Z","steps":["trace[1451807041] 'agreement among raft nodes before linearized reading' (duration: 230.522755ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:48.870104Z","caller":"traceutil/trace.go:171","msg":"trace[519033620] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:5638; }","duration":"154.724532ms","start":"2026-03-27T02:06:48.715332Z","end":"2026-03-27T02:06:48.870056Z","steps":["trace[519033620] 'agreement among raft nodes before linearized reading' (duration: 154.358141ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:49.008004Z","caller":"traceutil/trace.go:171","msg":"trace[602885961] transaction","detail":"{read_only:false; response_revision:5640; number_of_response:1; }","duration":"130.06176ms","start":"2026-03-27T02:06:48.877919Z","end":"2026-03-27T02:06:49.007981Z","steps":["trace[602885961] 'process raft request' (duration: 58.580612ms)","trace[602885961] 'compare' (duration: 71.315294ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:06:49.008525Z","caller":"traceutil/trace.go:171","msg":"trace[157562610] transaction","detail":"{read_only:false; response_revision:5641; number_of_response:1; }","duration":"130.238195ms","start":"2026-03-27T02:06:48.878252Z","end":"2026-03-27T02:06:49.00849Z","steps":["trace[157562610] 'process raft request' (duration: 129.662849ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:49.008722Z","caller":"traceutil/trace.go:171","msg":"trace[1553667991] transaction","detail":"{read_only:false; response_revision:5642; number_of_response:1; }","duration":"130.361298ms","start":"2026-03-27T02:06:48.878332Z","end":"2026-03-27T02:06:49.008693Z","steps":["trace[1553667991] 'process raft request' (duration: 130.024899ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:06:49.008661Z","caller":"traceutil/trace.go:171","msg":"trace[102723197] linearizableReadLoop","detail":"{readStateIndex:5849; appliedIndex:5847; }","duration":"130.403469ms","start":"2026-03-27T02:06:48.878225Z","end":"2026-03-27T02:06:49.008628Z","steps":["trace[102723197] 'read index received' (duration: 28.408073ms)","trace[102723197] 'applied index is now lower than readState.Index' (duration: 101.993536ms)"],"step_count":2} {"level":"warn","ts":"2026-03-27T02:06:49.00911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.8248ms","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-03-27T02:06:49.009237Z","caller":"traceutil/trace.go:171","msg":"trace[1354836845] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5642; }","duration":"130.997336ms","start":"2026-03-27T02:06:48.878208Z","end":"2026-03-27T02:06:49.009206Z","steps":["trace[1354836845] 'agreement among raft nodes before linearized reading' (duration: 130.620186ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:06:49.010099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.033122ms","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-03-27T02:06:49.010229Z","caller":"traceutil/trace.go:171","msg":"trace[1727773929] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5642; }","duration":"110.218828ms","start":"2026-03-27T02:06:48.899981Z","end":"2026-03-27T02:06:49.0102Z","steps":["trace[1727773929] 'agreement among raft nodes before linearized reading' (duration: 109.96268ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:07:36.678125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2988} {"level":"info","ts":"2026-03-27T02:07:36.749325Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2988,"took":"69.526496ms","hash":400636988,"current-db-size-bytes":58167296,"current-db-size":"58 MB","current-db-size-in-use-bytes":33644544,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-03-27T02:07:36.749401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":400636988,"revision":2988,"compact-revision":-1} {"level":"info","ts":"2026-03-27T02:12:36.68728Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6051} {"level":"info","ts":"2026-03-27T02:12:36.791112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6051,"took":"101.494391ms","hash":4104417045,"current-db-size-bytes":58167296,"current-db-size":"58 MB","current-db-size-in-use-bytes":23318528,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-27T02:12:36.791196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4104417045,"revision":6051,"compact-revision":2988} {"level":"info","ts":"2026-03-27T02:12:40.206765Z","caller":"traceutil/trace.go:171","msg":"trace[1014752678] linearizableReadLoop","detail":"{readStateIndex:8586; appliedIndex:8585; }","duration":"170.414549ms","start":"2026-03-27T02:12:40.036318Z","end":"2026-03-27T02:12:40.206733Z","steps":["trace[1014752678] 'read index received' (duration: 170.154982ms)","trace[1014752678] 'applied index is now lower than readState.Index' (duration: 258.327µs)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:12:40.206826Z","caller":"traceutil/trace.go:171","msg":"trace[1792073420] transaction","detail":"{read_only:false; response_revision:8291; number_of_response:1; }","duration":"233.944856ms","start":"2026-03-27T02:12:39.972836Z","end":"2026-03-27T02:12:40.206781Z","steps":["trace[1792073420] 'process raft request' (duration: 233.70974ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:12:40.206993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.700996ms","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-03-27T02:12:40.207036Z","caller":"traceutil/trace.go:171","msg":"trace[538039968] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8291; }","duration":"110.83199ms","start":"2026-03-27T02:12:40.096192Z","end":"2026-03-27T02:12:40.207024Z","steps":["trace[538039968] 'agreement among raft nodes before linearized reading' (duration: 110.727167ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:12:40.207055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.677147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-27T02:12:40.207222Z","caller":"traceutil/trace.go:171","msg":"trace[1142314863] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8291; }","duration":"170.918423ms","start":"2026-03-27T02:12:40.036276Z","end":"2026-03-27T02:12:40.207194Z","steps":["trace[1142314863] 'agreement among raft nodes before linearized reading' (duration: 170.594975ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:12:44.335425Z","caller":"traceutil/trace.go:171","msg":"trace[2073834039] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"108.080096ms","start":"2026-03-27T02:12:44.227312Z","end":"2026-03-27T02:12:44.335392Z","steps":["trace[2073834039] 'process raft request' (duration: 107.85039ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:12:44.844366Z","caller":"traceutil/trace.go:171","msg":"trace[2089102546] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"231.061688ms","start":"2026-03-27T02:12:44.613274Z","end":"2026-03-27T02:12:44.844336Z","steps":["trace[2089102546] 'process raft request' (duration: 230.824462ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:13:01.014535Z","caller":"traceutil/trace.go:171","msg":"trace[1137888561] transaction","detail":"{read_only:false; response_revision:8404; number_of_response:1; }","duration":"103.960716ms","start":"2026-03-27T02:13:00.910544Z","end":"2026-03-27T02:13:01.014505Z","steps":["trace[1137888561] 'process raft request' (duration: 103.75197ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:13:01.61321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.325024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-27T02:13:01.613369Z","caller":"traceutil/trace.go:171","msg":"trace[1372218468] transaction","detail":"{read_only:false; response_revision:8407; number_of_response:1; }","duration":"201.420228ms","start":"2026-03-27T02:13:01.411921Z","end":"2026-03-27T02:13:01.613342Z","steps":["trace[1372218468] 'process raft request' (duration: 93.829896ms)","trace[1372218468] 'compare' (duration: 107.15045ms)"],"step_count":2} {"level":"info","ts":"2026-03-27T02:13:14.710773Z","caller":"traceutil/trace.go:171","msg":"trace[1021848702] linearizableReadLoop","detail":"{readStateIndex:8830; appliedIndex:8829; }","duration":"129.327603ms","start":"2026-03-27T02:13:14.581412Z","end":"2026-03-27T02:13:14.71074Z","steps":["trace[1021848702] 'read index received' (duration: 129.008455ms)","trace[1021848702] 'applied index is now lower than readState.Index' (duration: 317.358µs)"],"step_count":2} {"level":"warn","ts":"2026-03-27T02:13:14.711039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.528359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-27T02:13:14.711141Z","caller":"traceutil/trace.go:171","msg":"trace[1088408003] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:8527; }","duration":"129.748025ms","start":"2026-03-27T02:13:14.581376Z","end":"2026-03-27T02:13:14.711124Z","steps":["trace[1088408003] 'agreement among raft nodes before linearized reading' (duration: 129.494758ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:13:14.711712Z","caller":"traceutil/trace.go:171","msg":"trace[1965510606] transaction","detail":"{read_only:false; response_revision:8527; number_of_response:1; }","duration":"210.409347ms","start":"2026-03-27T02:13:14.501165Z","end":"2026-03-27T02:13:14.711574Z","steps":["trace[1965510606] 'process raft request' (duration: 209.318869ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:13:26.971808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.036998ms","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":"warn","ts":"2026-03-27T02:13:26.971839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.163308ms","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-03-27T02:13:26.971923Z","caller":"traceutil/trace.go:171","msg":"trace[1809126652] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8633; }","duration":"167.211423ms","start":"2026-03-27T02:13:26.804685Z","end":"2026-03-27T02:13:26.971897Z","steps":["trace[1809126652] 'range keys from in-memory index tree' (duration: 166.793892ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:13:26.971937Z","caller":"traceutil/trace.go:171","msg":"trace[1457031276] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8633; }","duration":"129.335153ms","start":"2026-03-27T02:13:26.84258Z","end":"2026-03-27T02:13:26.971916Z","steps":["trace[1457031276] 'count revisions from in-memory index tree' (duration: 129.054136ms)"],"step_count":1} {"level":"warn","ts":"2026-03-27T02:13:27.725515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.192612ms","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-03-27T02:13:27.725746Z","caller":"traceutil/trace.go:171","msg":"trace[1369732409] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8640; }","duration":"101.467339ms","start":"2026-03-27T02:13:27.624256Z","end":"2026-03-27T02:13:27.725723Z","steps":["trace[1369732409] 'range keys from in-memory index tree' (duration: 100.990506ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:13:28.643894Z","caller":"traceutil/trace.go:171","msg":"trace[1990739165] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"145.258349ms","start":"2026-03-27T02:13:28.498594Z","end":"2026-03-27T02:13:28.643852Z","steps":["trace[1990739165] 'process raft request' (duration: 145.053743ms)"],"step_count":1} {"level":"info","ts":"2026-03-27T02:14:08.141198Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002476.wal"} {"level":"info","ts":"2026-03-27T02:15:19.722217Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-27T02:15:19.734084Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-27T02:15:19.734203Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-27T02:17:36.69445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8270} {"level":"info","ts":"2026-03-27T02:17:36.778783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8270,"took":"81.022774ms","hash":864837691,"current-db-size-bytes":58167296,"current-db-size":"58 MB","current-db-size-in-use-bytes":26030080,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-27T02:17:36.778876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":864837691,"revision":8270,"compact-revision":6051} {"level":"info","ts":"2026-03-27T02:22:36.70039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10671} {"level":"info","ts":"2026-03-27T02:22:36.788003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10671,"took":"85.481353ms","hash":3066248767,"current-db-size-bytes":58167296,"current-db-size":"58 MB","current-db-size-in-use-bytes":20815872,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-03-27T02:22:36.788082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3066248767,"revision":10671,"compact-revision":8270}