{"level":"warn","ts":"2026-07-17T05:29:47.315016Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T05:29:47.315129Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-17T05:29:47.3152Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T05:29:47.315214Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-17T05:29:47.315233Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T05:29:47.315865Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-07-17T05:29:47.315937Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-17T05:29:47.320264Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.116598ms"} {"level":"info","ts":"2026-07-17T05:29:47.332919Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-07-17T05:29:47.333001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T05:29:47.333029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-07-17T05:29:47.333046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T05:29:47.333061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-07-17T05:29:47.333105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-07-17T05:29:47.343871Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T05:29:47.346056Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T05:29:47.347316Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-17T05:29:47.351733Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T05:29:47.352052Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T05:29:47.352216Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T05:29:47.352247Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T05:29:47.352132Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T05:29:47.353376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-07-17T05:29:47.353511Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-17T05:29:47.356332Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T05:29:47.356427Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-17T05:29:47.35649Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-17T05:29:47.356696Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T05:29:47.35674Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T05:29:48.233384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T05:29:48.233473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T05:29:48.233499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-07-17T05:29:48.233526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-07-17T05:29:48.233537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-17T05:29:48.233552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-07-17T05:29:48.233566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-17T05:29:48.234863Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T05:29:48.234898Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:29:48.235003Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T05:29:48.235066Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T05:29:48.235172Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T05:29:48.235302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T05:29:48.236156Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:29:48.236298Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:29:48.236331Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:29:48.238322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T05:29:48.238758Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-07-17T05:29:51.452932Z","caller":"traceutil/trace.go:171","msg":"trace[1876399285] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"125.77368ms","start":"2026-07-17T05:29:51.327115Z","end":"2026-07-17T05:29:51.452888Z","steps":["trace[1876399285] 'process raft request' (duration: 121.788985ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:02.251863Z","caller":"traceutil/trace.go:171","msg":"trace[1892420857] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"177.810607ms","start":"2026-07-17T05:30:02.074026Z","end":"2026-07-17T05:30:02.251837Z","steps":["trace[1892420857] 'read index received' (duration: 177.600242ms)","trace[1892420857] 'applied index is now lower than readState.Index' (duration: 209.375µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:30:02.252034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.970601ms","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-07-17T05:30:02.252138Z","caller":"traceutil/trace.go:171","msg":"trace[1185274729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:402; }","duration":"178.133577ms","start":"2026-07-17T05:30:02.073985Z","end":"2026-07-17T05:30:02.252118Z","steps":["trace[1185274729] 'agreement among raft nodes before linearized reading' (duration: 177.967271ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:02.252246Z","caller":"traceutil/trace.go:171","msg":"trace[1846512998] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"181.372791ms","start":"2026-07-17T05:30:02.070853Z","end":"2026-07-17T05:30:02.252226Z","steps":["trace[1846512998] 'process raft request' (duration: 180.797756ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:02.724952Z","caller":"traceutil/trace.go:171","msg":"trace[626563087] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"467.726291ms","start":"2026-07-17T05:30:02.257197Z","end":"2026-07-17T05:30:02.724923Z","steps":["trace[626563087] 'process raft request' (duration: 394.538844ms)","trace[626563087] 'compare' (duration: 72.775496ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:30:02.725114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.774269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:30:02.725168Z","caller":"traceutil/trace.go:171","msg":"trace[1281384955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:403; }","duration":"258.887133ms","start":"2026-07-17T05:30:02.466267Z","end":"2026-07-17T05:30:02.725154Z","steps":["trace[1281384955] 'agreement among raft nodes before linearized reading' (duration: 258.74833ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:02.724929Z","caller":"traceutil/trace.go:171","msg":"trace[1127894130] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"258.573584ms","start":"2026-07-17T05:30:02.466313Z","end":"2026-07-17T05:30:02.724886Z","steps":["trace[1127894130] 'read index received' (duration: 185.455629ms)","trace[1127894130] 'applied index is now lower than readState.Index' (duration: 73.115675ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:30:02.725974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:02.257148Z","time spent":"467.908397ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:03.289533Z","caller":"traceutil/trace.go:171","msg":"trace[548996895] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"399.070884ms","start":"2026-07-17T05:30:02.890429Z","end":"2026-07-17T05:30:03.2895Z","steps":["trace[548996895] 'read index received' (duration: 398.715775ms)","trace[548996895] 'applied index is now lower than readState.Index' (duration: 353.399µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:03.289662Z","caller":"traceutil/trace.go:171","msg":"trace[663490578] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"552.014093ms","start":"2026-07-17T05:30:02.737606Z","end":"2026-07-17T05:30:03.28962Z","steps":["trace[663490578] 'process raft request' (duration: 551.671893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:03.289807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.347581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-17T05:30:03.289823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.022931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-17T05:30:03.289836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:02.737574Z","time spent":"552.167317ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:03.28986Z","caller":"traceutil/trace.go:171","msg":"trace[765347929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:404; }","duration":"399.437024ms","start":"2026-07-17T05:30:02.890406Z","end":"2026-07-17T05:30:03.289843Z","steps":["trace[765347929] 'agreement among raft nodes before linearized reading' (duration: 399.29715ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:03.289883Z","caller":"traceutil/trace.go:171","msg":"trace[522185038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"190.143004ms","start":"2026-07-17T05:30:03.099723Z","end":"2026-07-17T05:30:03.289866Z","steps":["trace[522185038] 'agreement among raft nodes before linearized reading' (duration: 190.015231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:03.289921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:02.890315Z","time spent":"399.595568ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-17T05:30:33.411589Z","caller":"traceutil/trace.go:171","msg":"trace[902826103] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"225.422377ms","start":"2026-07-17T05:30:33.18614Z","end":"2026-07-17T05:30:33.411562Z","steps":["trace[902826103] 'process raft request' (duration: 225.270423ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428357Z","caller":"traceutil/trace.go:171","msg":"trace[270730321] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"234.298513ms","start":"2026-07-17T05:30:33.194028Z","end":"2026-07-17T05:30:33.428326Z","steps":["trace[270730321] 'process raft request' (duration: 234.010246ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428599Z","caller":"traceutil/trace.go:171","msg":"trace[1416107126] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"226.562037ms","start":"2026-07-17T05:30:33.202003Z","end":"2026-07-17T05:30:33.428565Z","steps":["trace[1416107126] 'process raft request' (duration: 226.356602ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428654Z","caller":"traceutil/trace.go:171","msg":"trace[293661272] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"234.456227ms","start":"2026-07-17T05:30:33.194073Z","end":"2026-07-17T05:30:33.428529Z","steps":["trace[293661272] 'process raft request' (duration: 234.18684ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428675Z","caller":"traceutil/trace.go:171","msg":"trace[1369176993] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"223.192547ms","start":"2026-07-17T05:30:33.20543Z","end":"2026-07-17T05:30:33.428623Z","steps":["trace[1369176993] 'process raft request' (duration: 223.001813ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428742Z","caller":"traceutil/trace.go:171","msg":"trace[1618294066] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"222.848849ms","start":"2026-07-17T05:30:33.205851Z","end":"2026-07-17T05:30:33.4287Z","steps":["trace[1618294066] 'process raft request' (duration: 222.639943ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428846Z","caller":"traceutil/trace.go:171","msg":"trace[1153852701] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"222.301005ms","start":"2026-07-17T05:30:33.206528Z","end":"2026-07-17T05:30:33.428829Z","steps":["trace[1153852701] 'process raft request' (duration: 222.085868ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428889Z","caller":"traceutil/trace.go:171","msg":"trace[1805898829] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"215.70421ms","start":"2026-07-17T05:30:33.213166Z","end":"2026-07-17T05:30:33.428871Z","steps":["trace[1805898829] 'process raft request' (duration: 215.515415ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.428899Z","caller":"traceutil/trace.go:171","msg":"trace[396243283] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"222.887741ms","start":"2026-07-17T05:30:33.205946Z","end":"2026-07-17T05:30:33.428834Z","steps":["trace[396243283] 'process raft request' (duration: 222.608723ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.429018Z","caller":"traceutil/trace.go:171","msg":"trace[2038623282] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"198.179666ms","start":"2026-07-17T05:30:33.230818Z","end":"2026-07-17T05:30:33.428998Z","steps":["trace[2038623282] 'process raft request' (duration: 197.96612ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:33.429159Z","caller":"traceutil/trace.go:171","msg":"trace[1213109848] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"180.932348ms","start":"2026-07-17T05:30:33.248211Z","end":"2026-07-17T05:30:33.429144Z","steps":["trace[1213109848] 'process raft request' (duration: 180.736094ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:39.48976Z","caller":"traceutil/trace.go:171","msg":"trace[558083210] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"258.493592ms","start":"2026-07-17T05:30:39.231218Z","end":"2026-07-17T05:30:39.489711Z","steps":["trace[558083210] 'process raft request' (duration: 254.565078ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:39.665588Z","caller":"traceutil/trace.go:171","msg":"trace[1711206749] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"172.494175ms","start":"2026-07-17T05:30:39.493066Z","end":"2026-07-17T05:30:39.66556Z","steps":["trace[1711206749] 'process raft request' (duration: 172.324991ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:39.681447Z","caller":"traceutil/trace.go:171","msg":"trace[472682872] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"127.385703ms","start":"2026-07-17T05:30:39.554036Z","end":"2026-07-17T05:30:39.681421Z","steps":["trace[472682872] 'read index received' (duration: 111.340007ms)","trace[472682872] 'applied index is now lower than readState.Index' (duration: 16.044966ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:39.6815Z","caller":"traceutil/trace.go:171","msg":"trace[1982062545] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"141.482355ms","start":"2026-07-17T05:30:39.539995Z","end":"2026-07-17T05:30:39.681478Z","steps":["trace[1982062545] 'process raft request' (duration: 141.326481ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:39.681676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.624188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-17T05:30:39.681679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.634068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-56vzj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-17T05:30:39.681732Z","caller":"traceutil/trace.go:171","msg":"trace[819052889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"127.730371ms","start":"2026-07-17T05:30:39.553986Z","end":"2026-07-17T05:30:39.681716Z","steps":["trace[819052889] 'agreement among raft nodes before linearized reading' (duration: 127.543516ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:39.681742Z","caller":"traceutil/trace.go:171","msg":"trace[1236241895] range","detail":"{range_begin:/registry/pods/kube-system/cilium-56vzj; range_end:; response_count:1; response_revision:649; }","duration":"127.738581ms","start":"2026-07-17T05:30:39.553985Z","end":"2026-07-17T05:30:39.681724Z","steps":["trace[1236241895] 'agreement among raft nodes before linearized reading' (duration: 127.515136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.926975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882337622411883,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T05:30:40.93316Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.234943221s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T05:30:40.934432Z","caller":"traceutil/trace.go:171","msg":"trace[222048745] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.236360238s","start":"2026-07-17T05:30:39.698044Z","end":"2026-07-17T05:30:40.934405Z","steps":["trace[222048745] 'process raft request' (duration: 1.235364361s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.934596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:39.698013Z","time spent":"1.236493602s","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:40.943127Z","caller":"traceutil/trace.go:171","msg":"trace[1801534552] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"857.450358ms","start":"2026-07-17T05:30:40.085654Z","end":"2026-07-17T05:30:40.943104Z","steps":["trace[1801534552] 'process raft request' (duration: 856.914274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.943251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:40.08562Z","time spent":"857.563991ms","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:40.943245Z","caller":"traceutil/trace.go:171","msg":"trace[1465906606] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:675; }","duration":"517.227411ms","start":"2026-07-17T05:30:40.426Z","end":"2026-07-17T05:30:40.943228Z","steps":["trace[1465906606] 'read index received' (duration: 507.473143ms)","trace[1465906606] 'applied index is now lower than readState.Index' (duration: 9.753068ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:40.94331Z","caller":"traceutil/trace.go:171","msg":"trace[887041644] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"726.183303ms","start":"2026-07-17T05:30:40.217106Z","end":"2026-07-17T05:30:40.94329Z","steps":["trace[887041644] 'process raft request' (duration: 725.929126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.943363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.252326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:30:40.943387Z","caller":"traceutil/trace.go:171","msg":"trace[1214691021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"275.318148ms","start":"2026-07-17T05:30:40.668061Z","end":"2026-07-17T05:30:40.943379Z","steps":["trace[1214691021] 'agreement among raft nodes before linearized reading' (duration: 275.264967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.943419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:40.217079Z","time spent":"726.279206ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:30:40.94354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.50749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T05:30:40.943623Z","caller":"traceutil/trace.go:171","msg":"trace[1381317929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"517.634753ms","start":"2026-07-17T05:30:40.425966Z","end":"2026-07-17T05:30:40.943601Z","steps":["trace[1381317929] 'agreement among raft nodes before linearized reading' (duration: 517.354595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:40.943667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:40.425946Z","time spent":"517.713055ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T05:30:55.629666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.217334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T05:30:55.629767Z","caller":"traceutil/trace.go:171","msg":"trace[1858941008] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:815; }","duration":"162.381788ms","start":"2026-07-17T05:30:55.467367Z","end":"2026-07-17T05:30:55.629748Z","steps":["trace[1858941008] 'count revisions from in-memory index tree' (duration: 162.05518ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:55.629703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.762425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T05:30:55.629971Z","caller":"traceutil/trace.go:171","msg":"trace[1681194541] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:815; }","duration":"269.024691ms","start":"2026-07-17T05:30:55.360859Z","end":"2026-07-17T05:30:55.629884Z","steps":["trace[1681194541] 'count revisions from in-memory index tree' (duration: 268.691243ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:55.999166Z","caller":"traceutil/trace.go:171","msg":"trace[1345522084] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"329.665917ms","start":"2026-07-17T05:30:55.669482Z","end":"2026-07-17T05:30:55.999147Z","steps":["trace[1345522084] 'read index received' (duration: 329.577105ms)","trace[1345522084] 'applied index is now lower than readState.Index' (duration: 88.182µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:30:55.999296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.79807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:30:55.999288Z","caller":"traceutil/trace.go:171","msg":"trace[1297382071] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"343.00619ms","start":"2026-07-17T05:30:55.656248Z","end":"2026-07-17T05:30:55.999254Z","steps":["trace[1297382071] 'process raft request' (duration: 342.766023ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:55.999341Z","caller":"traceutil/trace.go:171","msg":"trace[895563554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"329.878483ms","start":"2026-07-17T05:30:55.669453Z","end":"2026-07-17T05:30:55.999331Z","steps":["trace[895563554] 'agreement among raft nodes before linearized reading' (duration: 329.801111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:55.999371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:55.669444Z","time spent":"329.921183ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T05:30:55.999435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:55.65623Z","time spent":"343.124633ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:30:55.999504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.592416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-17T05:30:55.999427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.77305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-17T05:30:55.999535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.917761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:30:55.999584Z","caller":"traceutil/trace.go:171","msg":"trace[1076355986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"201.714239ms","start":"2026-07-17T05:30:55.797848Z","end":"2026-07-17T05:30:55.999562Z","steps":["trace[1076355986] 'agreement among raft nodes before linearized reading' (duration: 201.513744ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:55.999602Z","caller":"traceutil/trace.go:171","msg":"trace[590917671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"258.999557ms","start":"2026-07-17T05:30:55.740577Z","end":"2026-07-17T05:30:55.999576Z","steps":["trace[590917671] 'agreement among raft nodes before linearized reading' (duration: 258.71203ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:55.999632Z","caller":"traceutil/trace.go:171","msg":"trace[167285119] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:816; }","duration":"251.047115ms","start":"2026-07-17T05:30:55.748566Z","end":"2026-07-17T05:30:55.999613Z","steps":["trace[167285119] 'agreement among raft nodes before linearized reading' (duration: 250.85606ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:31:47.245018Z","caller":"traceutil/trace.go:171","msg":"trace[327545058] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"194.391027ms","start":"2026-07-17T05:31:47.050594Z","end":"2026-07-17T05:31:47.244985Z","steps":["trace[327545058] 'process raft request' (duration: 194.12431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:10.890855Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882337622414324,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T05:32:10.949466Z","caller":"traceutil/trace.go:171","msg":"trace[822930543] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1952; }","duration":"559.159568ms","start":"2026-07-17T05:32:10.390284Z","end":"2026-07-17T05:32:10.949443Z","steps":["trace[822930543] 'read index received' (duration: 558.981194ms)","trace[822930543] 'applied index is now lower than readState.Index' (duration: 177.464µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:10.949615Z","caller":"traceutil/trace.go:171","msg":"trace[1000595364] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"585.90533ms","start":"2026-07-17T05:32:10.363676Z","end":"2026-07-17T05:32:10.949581Z","steps":["trace[1000595364] 'process raft request' (duration: 585.622933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:10.949675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.375403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-17T05:32:10.949709Z","caller":"traceutil/trace.go:171","msg":"trace[365291995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1878; }","duration":"559.421374ms","start":"2026-07-17T05:32:10.390278Z","end":"2026-07-17T05:32:10.9497Z","steps":["trace[365291995] 'agreement among raft nodes before linearized reading' (duration: 559.301821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:10.949705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.38226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-17T05:32:10.949759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:10.390238Z","time spent":"559.505758ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T05:32:10.949801Z","caller":"traceutil/trace.go:171","msg":"trace[1095364371] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1878; }","duration":"457.534294ms","start":"2026-07-17T05:32:10.492245Z","end":"2026-07-17T05:32:10.949779Z","steps":["trace[1095364371] 'agreement among raft nodes before linearized reading' (duration: 457.362839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:10.949809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:10.363664Z","time spent":"586.055755ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:10.94984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.585529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c904a29a-b43a-43db-a395-b426aea55dd8\" ","response":"range_response_count:1 size:3747"} {"level":"warn","ts":"2026-07-17T05:32:10.949859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:10.492222Z","time spent":"457.625887ms","remote":"127.0.0.1:51470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":2,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-17T05:32:10.949893Z","caller":"traceutil/trace.go:171","msg":"trace[1069795923] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c904a29a-b43a-43db-a395-b426aea55dd8; range_end:; response_count:1; response_revision:1878; }","duration":"286.693112ms","start":"2026-07-17T05:32:10.663188Z","end":"2026-07-17T05:32:10.949881Z","steps":["trace[1069795923] 'agreement among raft nodes before linearized reading' (duration: 286.532687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:11.679706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.35172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c2fcc5be725b78\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-07-17T05:32:11.679785Z","caller":"traceutil/trace.go:171","msg":"trace[39939263] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c2fcc5be725b78; range_end:; response_count:1; response_revision:1882; }","duration":"354.483914ms","start":"2026-07-17T05:32:11.325283Z","end":"2026-07-17T05:32:11.679767Z","steps":["trace[39939263] 'range keys from in-memory index tree' (duration: 354.175546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:11.67982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:11.325261Z","time spent":"354.551826ms","remote":"127.0.0.1:51098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1003,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c2fcc5be725b78\" "} {"level":"info","ts":"2026-07-17T05:32:11.680579Z","caller":"traceutil/trace.go:171","msg":"trace[1501919275] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"255.337435ms","start":"2026-07-17T05:32:11.425217Z","end":"2026-07-17T05:32:11.680555Z","steps":["trace[1501919275] 'read index received' (duration: 255.11206ms)","trace[1501919275] 'applied index is now lower than readState.Index' (duration: 224.105µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:11.680598Z","caller":"traceutil/trace.go:171","msg":"trace[525988147] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"311.538904ms","start":"2026-07-17T05:32:11.369042Z","end":"2026-07-17T05:32:11.68058Z","steps":["trace[525988147] 'process raft request' (duration: 311.351689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:11.68079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.9617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T05:32:11.680837Z","caller":"traceutil/trace.go:171","msg":"trace[209625842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1883; }","duration":"254.034322ms","start":"2026-07-17T05:32:11.426789Z","end":"2026-07-17T05:32:11.680823Z","steps":["trace[209625842] 'agreement among raft nodes before linearized reading' (duration: 253.901319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:11.680847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:11.369025Z","time spent":"311.637188ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:11.680908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.628763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T05:32:11.680998Z","caller":"traceutil/trace.go:171","msg":"trace[2061313826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1883; }","duration":"255.798528ms","start":"2026-07-17T05:32:11.425178Z","end":"2026-07-17T05:32:11.680977Z","steps":["trace[2061313826] 'agreement among raft nodes before linearized reading' (duration: 255.50461ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.312498Z","caller":"traceutil/trace.go:171","msg":"trace[838527261] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"299.299833ms","start":"2026-07-17T05:32:25.013172Z","end":"2026-07-17T05:32:25.312471Z","steps":["trace[838527261] 'process raft request' (duration: 299.097588ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.312508Z","caller":"traceutil/trace.go:171","msg":"trace[1211363825] linearizableReadLoop","detail":"{readStateIndex:2075; appliedIndex:2075; }","duration":"286.655211ms","start":"2026-07-17T05:32:25.025821Z","end":"2026-07-17T05:32:25.312476Z","steps":["trace[1211363825] 'read index received' (duration: 286.64606ms)","trace[1211363825] 'applied index is now lower than readState.Index' (duration: 7.461µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:25.312767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.899647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T05:32:25.312836Z","caller":"traceutil/trace.go:171","msg":"trace[1966820068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1997; }","duration":"287.015959ms","start":"2026-07-17T05:32:25.025803Z","end":"2026-07-17T05:32:25.312819Z","steps":["trace[1966820068] 'agreement among raft nodes before linearized reading' (duration: 286.779813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.320707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.115027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T05:32:25.320765Z","caller":"traceutil/trace.go:171","msg":"trace[531555711] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1999; }","duration":"291.188299ms","start":"2026-07-17T05:32:25.029561Z","end":"2026-07-17T05:32:25.320749Z","steps":["trace[531555711] 'agreement among raft nodes before linearized reading' (duration: 291.061356ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.320902Z","caller":"traceutil/trace.go:171","msg":"trace[2145749136] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"221.907497ms","start":"2026-07-17T05:32:25.098976Z","end":"2026-07-17T05:32:25.320883Z","steps":["trace[2145749136] 'process raft request' (duration: 221.512996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.32092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.908124ms","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-07-17T05:32:25.320996Z","caller":"traceutil/trace.go:171","msg":"trace[1901943019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1999; }","duration":"212.077558ms","start":"2026-07-17T05:32:25.108896Z","end":"2026-07-17T05:32:25.320973Z","steps":["trace[1901943019] 'agreement among raft nodes before linearized reading' (duration: 211.809461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.320968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.634649ms","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-07-17T05:32:25.321084Z","caller":"traceutil/trace.go:171","msg":"trace[2032623572] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1999; }","duration":"270.756391ms","start":"2026-07-17T05:32:25.050276Z","end":"2026-07-17T05:32:25.321032Z","steps":["trace[2032623572] 'agreement among raft nodes before linearized reading' (duration: 270.530726ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:33.86896Z","caller":"traceutil/trace.go:171","msg":"trace[121990294] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"119.75399ms","start":"2026-07-17T05:32:33.749157Z","end":"2026-07-17T05:32:33.868911Z","steps":["trace[121990294] 'process raft request' (duration: 119.535344ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:55.724599Z","caller":"traceutil/trace.go:171","msg":"trace[1003352528] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2264; }","duration":"140.120716ms","start":"2026-07-17T05:32:55.584456Z","end":"2026-07-17T05:32:55.724577Z","steps":["trace[1003352528] 'read index received' (duration: 139.937471ms)","trace[1003352528] 'applied index is now lower than readState.Index' (duration: 182.145µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:55.724661Z","caller":"traceutil/trace.go:171","msg":"trace[1893768960] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"159.464544ms","start":"2026-07-17T05:32:55.565165Z","end":"2026-07-17T05:32:55.724629Z","steps":["trace[1893768960] 'process raft request' (duration: 159.285899ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:55.724825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.357421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-17T05:32:55.724869Z","caller":"traceutil/trace.go:171","msg":"trace[133690534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2181; }","duration":"140.439364ms","start":"2026-07-17T05:32:55.584419Z","end":"2026-07-17T05:32:55.724859Z","steps":["trace[133690534] 'agreement among raft nodes before linearized reading' (duration: 140.2806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:55.724906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.856151ms","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-07-17T05:32:55.724985Z","caller":"traceutil/trace.go:171","msg":"trace[1430284967] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2181; }","duration":"111.978414ms","start":"2026-07-17T05:32:55.612989Z","end":"2026-07-17T05:32:55.724968Z","steps":["trace[1430284967] 'agreement among raft nodes before linearized reading' (duration: 111.79034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:01.942096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.33271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-17T05:33:01.942194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.500777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:33:01.942217Z","caller":"traceutil/trace.go:171","msg":"trace[916344146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2213; }","duration":"172.553908ms","start":"2026-07-17T05:33:01.769656Z","end":"2026-07-17T05:33:01.94221Z","steps":["trace[916344146] 'range keys from in-memory index tree' (duration: 172.431565ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:01.942203Z","caller":"traceutil/trace.go:171","msg":"trace[1505255273] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2213; }","duration":"167.490494ms","start":"2026-07-17T05:33:01.77469Z","end":"2026-07-17T05:33:01.942181Z","steps":["trace[1505255273] 'range keys from in-memory index tree' (duration: 167.110885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:01.942238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.978664ms","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-07-17T05:33:01.942283Z","caller":"traceutil/trace.go:171","msg":"trace[1973602032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2213; }","duration":"177.072577ms","start":"2026-07-17T05:33:01.765198Z","end":"2026-07-17T05:33:01.942271Z","steps":["trace[1973602032] 'range keys from in-memory index tree' (duration: 176.836761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:01.942533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.59563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-17T05:33:01.942596Z","caller":"traceutil/trace.go:171","msg":"trace[179411957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2213; }","duration":"196.702863ms","start":"2026-07-17T05:33:01.745879Z","end":"2026-07-17T05:33:01.942582Z","steps":["trace[179411957] 'range keys from in-memory index tree' (duration: 196.447727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:02.942689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.284247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T05:33:02.942783Z","caller":"traceutil/trace.go:171","msg":"trace[341268648] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2219; }","duration":"665.459172ms","start":"2026-07-17T05:33:02.277302Z","end":"2026-07-17T05:33:02.942762Z","steps":["trace[341268648] 'count revisions from in-memory index tree' (duration: 665.141824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:02.942829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:02.277271Z","time spent":"665.546934ms","remote":"127.0.0.1:51468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-17T05:33:03.104142Z","caller":"traceutil/trace.go:171","msg":"trace[1507930840] linearizableReadLoop","detail":"{readStateIndex:2307; appliedIndex:2306; }","duration":"433.4694ms","start":"2026-07-17T05:33:02.670649Z","end":"2026-07-17T05:33:03.104119Z","steps":["trace[1507930840] 'read index received' (duration: 433.246163ms)","trace[1507930840] 'applied index is now lower than readState.Index' (duration: 222.407µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:33:03.104408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.734526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:33:03.104455Z","caller":"traceutil/trace.go:171","msg":"trace[1145647062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2220; }","duration":"433.82539ms","start":"2026-07-17T05:33:02.670615Z","end":"2026-07-17T05:33:03.10444Z","steps":["trace[1145647062] 'agreement among raft nodes before linearized reading' (duration: 433.650405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:03.104491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:02.670593Z","time spent":"433.889611ms","remote":"127.0.0.1:50982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T05:33:03.104484Z","caller":"traceutil/trace.go:171","msg":"trace[598660840] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"823.54578ms","start":"2026-07-17T05:33:02.280701Z","end":"2026-07-17T05:33:03.104247Z","steps":["trace[598660840] 'process raft request' (duration: 823.263772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:03.104526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.36999ms","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-07-17T05:33:03.104618Z","caller":"traceutil/trace.go:171","msg":"trace[617574950] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2220; }","duration":"154.513314ms","start":"2026-07-17T05:33:02.950082Z","end":"2026-07-17T05:33:03.104596Z","steps":["trace[617574950] 'agreement among raft nodes before linearized reading' (duration: 154.236787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:03.104837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:02.28066Z","time spent":"823.92001ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:33:03.699384Z","caller":"traceutil/trace.go:171","msg":"trace[2021192091] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2307; }","duration":"127.73993ms","start":"2026-07-17T05:33:03.571613Z","end":"2026-07-17T05:33:03.699353Z","steps":["trace[2021192091] 'read index received' (duration: 127.571876ms)","trace[2021192091] 'applied index is now lower than readState.Index' (duration: 166.674µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:33:03.699532Z","caller":"traceutil/trace.go:171","msg":"trace[39818231] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"279.838751ms","start":"2026-07-17T05:33:03.419678Z","end":"2026-07-17T05:33:03.699517Z","steps":["trace[39818231] 'process raft request' (duration: 279.489342ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:03.699812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.178863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T05:33:03.699888Z","caller":"traceutil/trace.go:171","msg":"trace[746457042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2221; }","duration":"128.293415ms","start":"2026-07-17T05:33:03.571575Z","end":"2026-07-17T05:33:03.699869Z","steps":["trace[746457042] 'agreement among raft nodes before linearized reading' (duration: 128.068998ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:03.726734Z","caller":"traceutil/trace.go:171","msg":"trace[1373572292] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"144.447539ms","start":"2026-07-17T05:33:03.582257Z","end":"2026-07-17T05:33:03.726705Z","steps":["trace[1373572292] 'process raft request' (duration: 144.210153ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:03.726802Z","caller":"traceutil/trace.go:171","msg":"trace[1073055327] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"132.506555ms","start":"2026-07-17T05:33:03.594261Z","end":"2026-07-17T05:33:03.726767Z","steps":["trace[1073055327] 'process raft request' (duration: 132.359241ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:04.536245Z","caller":"traceutil/trace.go:171","msg":"trace[957435380] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"107.521385ms","start":"2026-07-17T05:34:04.428682Z","end":"2026-07-17T05:34:04.536203Z","steps":["trace[957435380] 'process raft request' (duration: 92.743576ms)","trace[957435380] 'compare' (duration: 14.489692ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:34:04.954597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.043668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:34:04.954751Z","caller":"traceutil/trace.go:171","msg":"trace[1164201812] linearizableReadLoop","detail":"{readStateIndex:2950; appliedIndex:2949; }","duration":"383.613605ms","start":"2026-07-17T05:34:04.57112Z","end":"2026-07-17T05:34:04.954733Z","steps":["trace[1164201812] 'read index received' (duration: 107.157685ms)","trace[1164201812] 'applied index is now lower than readState.Index' (duration: 276.45477ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:34:04.954857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.729518ms","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-07-17T05:34:04.954893Z","caller":"traceutil/trace.go:171","msg":"trace[894961706] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2839; }","duration":"383.789149ms","start":"2026-07-17T05:34:04.571094Z","end":"2026-07-17T05:34:04.954883Z","steps":["trace[894961706] 'agreement among raft nodes before linearized reading' (duration: 383.728108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:04.954941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:04.571082Z","time spent":"383.84096ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-07-17T05:34:04.954889Z","caller":"traceutil/trace.go:171","msg":"trace[1241123603] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"415.960937ms","start":"2026-07-17T05:34:04.538843Z","end":"2026-07-17T05:34:04.954804Z","steps":["trace[1241123603] 'process raft request' (duration: 139.480118ms)","trace[1241123603] 'compare' (duration: 275.904024ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:34:04.955084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.337091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:34:04.955165Z","caller":"traceutil/trace.go:171","msg":"trace[1206653167] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2839; }","duration":"258.484915ms","start":"2026-07-17T05:34:04.69666Z","end":"2026-07-17T05:34:04.955145Z","steps":["trace[1206653167] 'agreement among raft nodes before linearized reading' (duration: 258.334301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:04.955163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.510982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/percona-xtradb\" ","response":"range_response_count:1 size:724"} {"level":"warn","ts":"2026-07-17T05:34:04.955196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:04.538825Z","time spent":"416.188213ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:04.955229Z","caller":"traceutil/trace.go:171","msg":"trace[973544974] range","detail":"{range_begin:/registry/secrets/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2839; }","duration":"237.597245ms","start":"2026-07-17T05:34:04.717617Z","end":"2026-07-17T05:34:04.955214Z","steps":["trace[973544974] 'agreement among raft nodes before linearized reading' (duration: 237.375039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:04.955246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.070375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-09b56b32-09fb-4dc5-ba14-dbc3fdd715bb\" ","response":"range_response_count:1 size:3617"} {"level":"warn","ts":"2026-07-17T05:34:04.955276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.310074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-09b56b32-09fb-4dc5-ba14-dbc3fdd715bb\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-07-17T05:34:04.955329Z","caller":"traceutil/trace.go:171","msg":"trace[1023825897] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-09b56b32-09fb-4dc5-ba14-dbc3fdd715bb; range_end:; response_count:1; response_revision:2839; }","duration":"269.189168ms","start":"2026-07-17T05:34:04.686118Z","end":"2026-07-17T05:34:04.955307Z","steps":["trace[1023825897] 'agreement among raft nodes before linearized reading' (duration: 268.951671ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:04.955352Z","caller":"traceutil/trace.go:171","msg":"trace[925470487] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-09b56b32-09fb-4dc5-ba14-dbc3fdd715bb; range_end:; response_count:1; response_revision:2839; }","duration":"342.451601ms","start":"2026-07-17T05:34:04.612881Z","end":"2026-07-17T05:34:04.955333Z","steps":["trace[925470487] 'agreement among raft nodes before linearized reading' (duration: 342.086641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:04.955404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:04.612856Z","time spent":"342.535282ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3638,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-09b56b32-09fb-4dc5-ba14-dbc3fdd715bb\" "} {"level":"warn","ts":"2026-07-17T05:34:04.955457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.904281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:34:04.955541Z","caller":"traceutil/trace.go:171","msg":"trace[365675737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2839; }","duration":"285.255391ms","start":"2026-07-17T05:34:04.67027Z","end":"2026-07-17T05:34:04.955525Z","steps":["trace[365675737] 'agreement among raft nodes before linearized reading' (duration: 284.913802ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:05.356007Z","caller":"traceutil/trace.go:171","msg":"trace[404695661] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"393.042834ms","start":"2026-07-17T05:34:04.962938Z","end":"2026-07-17T05:34:05.35598Z","steps":["trace[404695661] 'process raft request' (duration: 392.042587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:05.356171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:04.962857Z","time spent":"393.237389ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3719,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:05.356506Z","caller":"traceutil/trace.go:171","msg":"trace[99664885] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"378.220243ms","start":"2026-07-17T05:34:04.978255Z","end":"2026-07-17T05:34:05.356475Z","steps":["trace[99664885] 'process raft request' (duration: 377.772041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:05.356962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:04.978232Z","time spent":"378.583362ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:22.36368Z","caller":"traceutil/trace.go:171","msg":"trace[1668509826] transaction","detail":"{read_only:false; response_revision:3005; number_of_response:1; }","duration":"169.088172ms","start":"2026-07-17T05:34:22.194566Z","end":"2026-07-17T05:34:22.363654Z","steps":["trace[1668509826] 'process raft request' (duration: 168.968829ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:24.127326Z","caller":"traceutil/trace.go:171","msg":"trace[1266764289] transaction","detail":"{read_only:false; response_revision:3043; number_of_response:1; }","duration":"128.371532ms","start":"2026-07-17T05:34:23.998928Z","end":"2026-07-17T05:34:24.127299Z","steps":["trace[1266764289] 'process raft request' (duration: 128.219779ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:24.16949Z","caller":"traceutil/trace.go:171","msg":"trace[889917906] linearizableReadLoop","detail":"{readStateIndex:3162; appliedIndex:3161; }","duration":"152.460136ms","start":"2026-07-17T05:34:24.016989Z","end":"2026-07-17T05:34:24.169449Z","steps":["trace[889917906] 'read index received' (duration: 110.612517ms)","trace[889917906] 'applied index is now lower than readState.Index' (duration: 41.846519ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:24.169832Z","caller":"traceutil/trace.go:171","msg":"trace[1747607692] transaction","detail":"{read_only:false; response_revision:3044; number_of_response:1; }","duration":"161.337209ms","start":"2026-07-17T05:34:24.008468Z","end":"2026-07-17T05:34:24.169805Z","steps":["trace[1747607692] 'process raft request' (duration: 160.820165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.169968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.949158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-07-17T05:34:24.170053Z","caller":"traceutil/trace.go:171","msg":"trace[2002368440] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:3044; }","duration":"153.080852ms","start":"2026-07-17T05:34:24.01695Z","end":"2026-07-17T05:34:24.170031Z","steps":["trace[2002368440] 'agreement among raft nodes before linearized reading' (duration: 152.818435ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:24.879945Z","caller":"traceutil/trace.go:171","msg":"trace[741260144] transaction","detail":"{read_only:false; response_revision:3046; number_of_response:1; }","duration":"496.116796ms","start":"2026-07-17T05:34:24.383805Z","end":"2026-07-17T05:34:24.879922Z","steps":["trace[741260144] 'process raft request' (duration: 495.963852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.880097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:24.383787Z","time spent":"496.232429ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:24.880751Z","caller":"traceutil/trace.go:171","msg":"trace[1620592149] linearizableReadLoop","detail":"{readStateIndex:3165; appliedIndex:3163; }","duration":"466.344303ms","start":"2026-07-17T05:34:24.414379Z","end":"2026-07-17T05:34:24.880723Z","steps":["trace[1620592149] 'read index received' (duration: 465.422159ms)","trace[1620592149] 'applied index is now lower than readState.Index' (duration: 920.384µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:24.880794Z","caller":"traceutil/trace.go:171","msg":"trace[1175211349] transaction","detail":"{read_only:false; response_revision:3047; number_of_response:1; }","duration":"494.441802ms","start":"2026-07-17T05:34:24.386322Z","end":"2026-07-17T05:34:24.880763Z","steps":["trace[1175211349] 'process raft request' (duration: 494.296228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.880982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:24.386297Z","time spent":"494.577686ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:34:24.880991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.60224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-17T05:34:24.881049Z","caller":"traceutil/trace.go:171","msg":"trace[223023612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3047; }","duration":"466.699873ms","start":"2026-07-17T05:34:24.414332Z","end":"2026-07-17T05:34:24.881032Z","steps":["trace[223023612] 'agreement among raft nodes before linearized reading' (duration: 466.541889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.881119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:24.414319Z","time spent":"466.782765ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-17T05:34:24.881302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.65211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-17T05:34:24.881357Z","caller":"traceutil/trace.go:171","msg":"trace[1014523933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3047; }","duration":"453.757204ms","start":"2026-07-17T05:34:24.427586Z","end":"2026-07-17T05:34:24.881344Z","steps":["trace[1014523933] 'agreement among raft nodes before linearized reading' (duration: 453.422284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.88134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.050177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-17T05:34:24.881396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:24.427558Z","time spent":"453.829965ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T05:34:24.881406Z","caller":"traceutil/trace.go:171","msg":"trace[12970654] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3047; }","duration":"331.165801ms","start":"2026-07-17T05:34:24.550225Z","end":"2026-07-17T05:34:24.88139Z","steps":["trace[12970654] 'agreement among raft nodes before linearized reading' (duration: 330.981595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.881441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:24.550203Z","time spent":"331.232283ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T05:34:24.881428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.368587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-17T05:34:24.881504Z","caller":"traceutil/trace.go:171","msg":"trace[127055616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3047; }","duration":"256.48787ms","start":"2026-07-17T05:34:24.624995Z","end":"2026-07-17T05:34:24.881483Z","steps":["trace[127055616] 'agreement among raft nodes before linearized reading' (duration: 256.184452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:24.881815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.289204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/valkey-node-0\" ","response":"range_response_count:1 size:17084"} {"level":"info","ts":"2026-07-17T05:34:24.881856Z","caller":"traceutil/trace.go:171","msg":"trace[948450664] range","detail":"{range_begin:/registry/pods/openstack/valkey-node-0; range_end:; response_count:1; response_revision:3047; }","duration":"122.498119ms","start":"2026-07-17T05:34:24.759345Z","end":"2026-07-17T05:34:24.881843Z","steps":["trace[948450664] 'agreement among raft nodes before linearized reading' (duration: 121.7869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:47.56323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.679645ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:34:47.563496Z","caller":"traceutil/trace.go:171","msg":"trace[644006474] transaction","detail":"{read_only:false; response_revision:3255; number_of_response:1; }","duration":"465.86954ms","start":"2026-07-17T05:34:47.097599Z","end":"2026-07-17T05:34:47.563469Z","steps":["trace[644006474] 'process raft request' (duration: 12.836806ms)","trace[644006474] 'compare' (duration: 452.393617ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:47.563571Z","caller":"traceutil/trace.go:171","msg":"trace[2080763024] linearizableReadLoop","detail":"{readStateIndex:3382; appliedIndex:3379; }","duration":"363.08025ms","start":"2026-07-17T05:34:47.200473Z","end":"2026-07-17T05:34:47.563553Z","steps":["trace[2080763024] 'read index received' (duration: 52.952µs)","trace[2080763024] 'applied index is now lower than readState.Index' (duration: 363.026078ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:34:47.56362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:47.09758Z","time spent":"465.978753ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:47.563635Z","caller":"traceutil/trace.go:171","msg":"trace[711897068] transaction","detail":"{read_only:false; response_revision:3256; number_of_response:1; }","duration":"465.927751ms","start":"2026-07-17T05:34:47.097682Z","end":"2026-07-17T05:34:47.56361Z","steps":["trace[711897068] 'process raft request' (duration: 465.692905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:47.563777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:47.09766Z","time spent":"466.037595ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:34:47.563787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.311296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6f258f7a-b8be-4baa-80ee-a2e45f64fb96\" ","response":"range_response_count:1 size:3719"} {"level":"info","ts":"2026-07-17T05:34:47.563766Z","caller":"traceutil/trace.go:171","msg":"trace[2124609332] transaction","detail":"{read_only:false; response_revision:3257; number_of_response:1; }","duration":"465.938883ms","start":"2026-07-17T05:34:47.097776Z","end":"2026-07-17T05:34:47.563715Z","steps":["trace[2124609332] 'process raft request' (duration: 465.714346ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:47.563844Z","caller":"traceutil/trace.go:171","msg":"trace[1122011043] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6f258f7a-b8be-4baa-80ee-a2e45f64fb96; range_end:; response_count:1; response_revision:3257; }","duration":"363.371888ms","start":"2026-07-17T05:34:47.200455Z","end":"2026-07-17T05:34:47.563827Z","steps":["trace[1122011043] 'agreement among raft nodes before linearized reading' (duration: 363.161211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:47.5639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:47.200385Z","time spent":"363.501461ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3740,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6f258f7a-b8be-4baa-80ee-a2e45f64fb96\" "} {"level":"warn","ts":"2026-07-17T05:34:47.563943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:47.097765Z","time spent":"466.092466ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:34:47.760188Z","caller":"traceutil/trace.go:171","msg":"trace[1509580294] transaction","detail":"{read_only:false; response_revision:3258; number_of_response:1; }","duration":"266.663857ms","start":"2026-07-17T05:34:47.493498Z","end":"2026-07-17T05:34:47.760162Z","steps":["trace[1509580294] 'process raft request' (duration: 231.284708ms)","trace[1509580294] 'compare' (duration: 35.085132ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:47.760323Z","caller":"traceutil/trace.go:171","msg":"trace[1310289226] transaction","detail":"{read_only:false; response_revision:3259; number_of_response:1; }","duration":"202.46282ms","start":"2026-07-17T05:34:47.55784Z","end":"2026-07-17T05:34:47.760303Z","steps":["trace[1310289226] 'process raft request' (duration: 202.173833ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:53.248499Z","caller":"traceutil/trace.go:171","msg":"trace[772090721] transaction","detail":"{read_only:false; response_revision:3310; number_of_response:1; }","duration":"212.281677ms","start":"2026-07-17T05:34:53.036182Z","end":"2026-07-17T05:34:53.248463Z","steps":["trace[772090721] 'process raft request' (duration: 212.044691ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:53.249884Z","caller":"traceutil/trace.go:171","msg":"trace[1617712283] linearizableReadLoop","detail":"{readStateIndex:3441; appliedIndex:3439; }","duration":"130.644302ms","start":"2026-07-17T05:34:53.119213Z","end":"2026-07-17T05:34:53.249857Z","steps":["trace[1617712283] 'read index received' (duration: 129.01828ms)","trace[1617712283] 'applied index is now lower than readState.Index' (duration: 1.624922ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:53.250011Z","caller":"traceutil/trace.go:171","msg":"trace[1439127717] transaction","detail":"{read_only:false; response_revision:3311; number_of_response:1; }","duration":"194.994634ms","start":"2026-07-17T05:34:53.054986Z","end":"2026-07-17T05:34:53.24998Z","steps":["trace[1439127717] 'process raft request' (duration: 194.708256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:53.250106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.878489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T05:34:53.250158Z","caller":"traceutil/trace.go:171","msg":"trace[1062745626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3311; }","duration":"130.988502ms","start":"2026-07-17T05:34:53.119154Z","end":"2026-07-17T05:34:53.250142Z","steps":["trace[1062745626] 'agreement among raft nodes before linearized reading' (duration: 130.816568ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:59.750262Z","caller":"traceutil/trace.go:171","msg":"trace[1961049327] transaction","detail":"{read_only:false; response_revision:3359; number_of_response:1; }","duration":"118.693928ms","start":"2026-07-17T05:34:59.631547Z","end":"2026-07-17T05:34:59.750241Z","steps":["trace[1961049327] 'process raft request' (duration: 118.564775ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:59.75049Z","caller":"traceutil/trace.go:171","msg":"trace[104690629] transaction","detail":"{read_only:false; response_revision:3360; number_of_response:1; }","duration":"118.651858ms","start":"2026-07-17T05:34:59.631809Z","end":"2026-07-17T05:34:59.750461Z","steps":["trace[104690629] 'process raft request' (duration: 118.387611ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.202509Z","caller":"traceutil/trace.go:171","msg":"trace[358189782] transaction","detail":"{read_only:false; response_revision:3361; number_of_response:1; }","duration":"394.938587ms","start":"2026-07-17T05:34:59.807523Z","end":"2026-07-17T05:35:00.202462Z","steps":["trace[358189782] 'process raft request' (duration: 383.284002ms)","trace[358189782] 'compare' (duration: 11.183644ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:00.202699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:59.807488Z","time spent":"395.111843ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:35:00.413341Z","caller":"traceutil/trace.go:171","msg":"trace[604248612] linearizableReadLoop","detail":"{readStateIndex:3495; appliedIndex:3493; }","duration":"427.158874ms","start":"2026-07-17T05:34:59.986156Z","end":"2026-07-17T05:35:00.413315Z","steps":["trace[604248612] 'read index received' (duration: 204.665408ms)","trace[604248612] 'applied index is now lower than readState.Index' (duration: 222.492026ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:35:00.413488Z","caller":"traceutil/trace.go:171","msg":"trace[197404893] transaction","detail":"{read_only:false; response_revision:3364; number_of_response:1; }","duration":"345.628541ms","start":"2026-07-17T05:35:00.067812Z","end":"2026-07-17T05:35:00.41344Z","steps":["trace[197404893] 'process raft request' (duration: 345.452947ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413504Z","caller":"traceutil/trace.go:171","msg":"trace[1551831530] transaction","detail":"{read_only:false; response_revision:3363; number_of_response:1; }","duration":"418.820454ms","start":"2026-07-17T05:34:59.994619Z","end":"2026-07-17T05:35:00.41344Z","steps":["trace[1551831530] 'process raft request' (duration: 418.578607ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413594Z","caller":"traceutil/trace.go:171","msg":"trace[542023389] transaction","detail":"{read_only:false; response_revision:3362; number_of_response:1; }","duration":"604.313598ms","start":"2026-07-17T05:34:59.809239Z","end":"2026-07-17T05:35:00.413552Z","steps":["trace[542023389] 'process raft request' (duration: 577.947495ms)","trace[542023389] 'compare' (duration: 25.850659ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:00.413615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.443832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db\" ","response":"range_response_count:1 size:7482"} {"level":"info","ts":"2026-07-17T05:35:00.413711Z","caller":"traceutil/trace.go:171","msg":"trace[1736893013] range","detail":"{range_begin:/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db; range_end:; response_count:1; response_revision:3364; }","duration":"427.575185ms","start":"2026-07-17T05:34:59.986088Z","end":"2026-07-17T05:35:00.413664Z","steps":["trace[1736893013] 'agreement among raft nodes before linearized reading' (duration: 427.37304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.413766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:59.994585Z","time spent":"419.04061ms","remote":"127.0.0.1:51206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9857,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:35:00.413778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:59.986065Z","time spent":"427.697198ms","remote":"127.0.0.1:42866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7503,"request content":"key:\"/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db\" "} {"level":"warn","ts":"2026-07-17T05:35:00.413817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:59.809205Z","time spent":"604.467562ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":484,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:35:00.413814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.067797Z","time spent":"345.897799ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:35:00.44301Z","caller":"traceutil/trace.go:171","msg":"trace[60766464] transaction","detail":"{read_only:false; response_revision:3365; number_of_response:1; }","duration":"150.281239ms","start":"2026-07-17T05:35:00.292698Z","end":"2026-07-17T05:35:00.442979Z","steps":["trace[60766464] 'process raft request' (duration: 150.093665ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.443103Z","caller":"traceutil/trace.go:171","msg":"trace[1116507486] transaction","detail":"{read_only:false; response_revision:3366; number_of_response:1; }","duration":"112.919466ms","start":"2026-07-17T05:35:00.330102Z","end":"2026-07-17T05:35:00.443022Z","steps":["trace[1116507486] 'process raft request' (duration: 112.829664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.802051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.395826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-17T05:35:00.802141Z","caller":"traceutil/trace.go:171","msg":"trace[231296438] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:3367; }","duration":"256.53006ms","start":"2026-07-17T05:35:00.545589Z","end":"2026-07-17T05:35:00.802119Z","steps":["trace[231296438] 'count revisions from in-memory index tree' (duration: 256.290064ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:26.43571Z","caller":"traceutil/trace.go:171","msg":"trace[1508939836] transaction","detail":"{read_only:false; response_revision:3610; number_of_response:1; }","duration":"143.548711ms","start":"2026-07-17T05:35:26.292131Z","end":"2026-07-17T05:35:26.43568Z","steps":["trace[1508939836] 'process raft request' (duration: 143.337586ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:26.450911Z","caller":"traceutil/trace.go:171","msg":"trace[342810911] transaction","detail":"{read_only:false; response_revision:3611; number_of_response:1; }","duration":"134.983036ms","start":"2026-07-17T05:35:26.315887Z","end":"2026-07-17T05:35:26.45087Z","steps":["trace[342810911] 'process raft request' (duration: 134.771861ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:46.755241Z","caller":"traceutil/trace.go:171","msg":"trace[1043072144] transaction","detail":"{read_only:false; response_revision:3758; number_of_response:1; }","duration":"217.958885ms","start":"2026-07-17T05:35:46.53726Z","end":"2026-07-17T05:35:46.755219Z","steps":["trace[1043072144] 'process raft request' (duration: 132.263324ms)","trace[1043072144] 'compare' (duration: 85.321482ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:35:46.809824Z","caller":"traceutil/trace.go:171","msg":"trace[1880079905] transaction","detail":"{read_only:false; response_revision:3759; number_of_response:1; }","duration":"226.181462ms","start":"2026-07-17T05:35:46.583614Z","end":"2026-07-17T05:35:46.809795Z","steps":["trace[1880079905] 'process raft request' (duration: 225.992667ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:46.810113Z","caller":"traceutil/trace.go:171","msg":"trace[1854076546] transaction","detail":"{read_only:false; response_revision:3760; number_of_response:1; }","duration":"141.129578ms","start":"2026-07-17T05:35:46.668954Z","end":"2026-07-17T05:35:46.810084Z","steps":["trace[1854076546] 'process raft request' (duration: 140.798779ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:46.810183Z","caller":"traceutil/trace.go:171","msg":"trace[1120651882] transaction","detail":"{read_only:false; response_revision:3761; number_of_response:1; }","duration":"141.122538ms","start":"2026-07-17T05:35:46.669042Z","end":"2026-07-17T05:35:46.810164Z","steps":["trace[1120651882] 'process raft request' (duration: 140.960504ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:46.810165Z","caller":"traceutil/trace.go:171","msg":"trace[1015350245] linearizableReadLoop","detail":"{readStateIndex:3923; appliedIndex:3921; }","duration":"225.165275ms","start":"2026-07-17T05:35:46.584967Z","end":"2026-07-17T05:35:46.810132Z","steps":["trace[1015350245] 'read index received' (duration: 84.550691ms)","trace[1015350245] 'applied index is now lower than readState.Index' (duration: 140.613514ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:46.810286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.310609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-07-17T05:35:46.810338Z","caller":"traceutil/trace.go:171","msg":"trace[704057588] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:3761; }","duration":"225.415451ms","start":"2026-07-17T05:35:46.584911Z","end":"2026-07-17T05:35:46.810326Z","steps":["trace[704057588] 'agreement among raft nodes before linearized reading' (duration: 225.316459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:47.421427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.99413ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-17T05:35:47.421695Z","caller":"traceutil/trace.go:171","msg":"trace[999786667] transaction","detail":"{read_only:false; response_revision:3762; number_of_response:1; }","duration":"490.766983ms","start":"2026-07-17T05:35:46.930914Z","end":"2026-07-17T05:35:47.421681Z","steps":["trace[999786667] 'process raft request' (duration: 490.599078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:47.42178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:46.93089Z","time spent":"490.835415ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:35:47.421974Z","caller":"traceutil/trace.go:171","msg":"trace[1292856862] linearizableReadLoop","detail":"{readStateIndex:3926; appliedIndex:3925; }","duration":"611.728671ms","start":"2026-07-17T05:35:46.810238Z","end":"2026-07-17T05:35:47.421967Z","steps":["trace[1292856862] 'read index received' (duration: 134.186716ms)","trace[1292856862] 'applied index is now lower than readState.Index' (duration: 477.541195ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:47.422104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.557131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T05:35:47.422126Z","caller":"traceutil/trace.go:171","msg":"trace[1491023056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3762; }","duration":"741.580542ms","start":"2026-07-17T05:35:46.68054Z","end":"2026-07-17T05:35:47.42212Z","steps":["trace[1491023056] 'agreement among raft nodes before linearized reading' (duration: 741.486909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:47.422146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:46.680479Z","time spent":"741.661403ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T05:35:47.422213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.796729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-controller\" ","response":"range_response_count:1 size:663"} {"level":"info","ts":"2026-07-17T05:35:47.422231Z","caller":"traceutil/trace.go:171","msg":"trace[1077657389] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-controller; range_end:; response_count:1; response_revision:3762; }","duration":"813.835669ms","start":"2026-07-17T05:35:46.608391Z","end":"2026-07-17T05:35:47.422226Z","steps":["trace[1077657389] 'agreement among raft nodes before linearized reading' (duration: 813.799428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:47.422246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:46.608379Z","time spent":"813.86352ms","remote":"127.0.0.1:51340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":684,"request content":"key:\"/registry/clusterroles/system:controller:ttl-controller\" "} {"level":"warn","ts":"2026-07-17T05:35:47.422366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.222811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-07-17T05:35:47.422388Z","caller":"traceutil/trace.go:171","msg":"trace[615528602] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:3762; }","duration":"524.288183ms","start":"2026-07-17T05:35:46.898095Z","end":"2026-07-17T05:35:47.422383Z","steps":["trace[615528602] 'agreement among raft nodes before linearized reading' (duration: 524.247422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:47.422402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:46.898069Z","time spent":"524.329475ms","remote":"127.0.0.1:51352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":436,"request content":"key:\"/registry/clusterrolebindings/system:coredns\" "}