{"level":"warn","ts":"2026-09-09T06:12:11.340888Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T06:12:11.341061Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.129: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://162.253.55.129:2380","--initial-cluster=instance=https://162.253.55.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.129: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-09-09T06:12:11.341183Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T06:12:11.341203Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-09T06:12:11.341231Z","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-09-09T06:12:11.344839Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"]} {"level":"info","ts":"2026-09-09T06:12:11.345045Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.129: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-09-09T06:12:11.354283Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.967256ms"} {"level":"info","ts":"2026-09-09T06:12:11.362699Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d232699cb6c87299","cluster-id":"f2b9115890c3fc7f"} {"level":"info","ts":"2026-09-09T06:12:11.362811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T06:12:11.36288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 0"} {"level":"info","ts":"2026-09-09T06:12:11.362904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d232699cb6c87299 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T06:12:11.362913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 1"} {"level":"info","ts":"2026-09-09T06:12:11.362963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"warn","ts":"2026-09-09T06:12:11.372681Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T06:12:11.374109Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T06:12:11.375476Z","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-09-09T06:12:11.377763Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d232699cb6c87299","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T06:12:11.377958Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d232699cb6c87299","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T06:12:11.378232Z","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-09-09T06:12:11.378352Z","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-09-09T06:12:11.378413Z","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-09-09T06:12:11.378826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"info","ts":"2026-09-09T06:12:11.379126Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","added-peer-id":"d232699cb6c87299","added-peer-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-09T06:12:11.382025Z","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-09-09T06:12:11.382258Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-09T06:12:11.382287Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-09T06:12:11.38265Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d232699cb6c87299","initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T06:12:11.38271Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T06:12:12.364268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T06:12:12.364343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T06:12:12.364392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgPreVoteResp from d232699cb6c87299 at term 1"} {"level":"info","ts":"2026-09-09T06:12:12.364415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became candidate at term 2"} {"level":"info","ts":"2026-09-09T06:12:12.364427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgVoteResp from d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-09T06:12:12.364613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became leader at term 2"} {"level":"info","ts":"2026-09-09T06:12:12.36464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d232699cb6c87299 elected leader d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-09T06:12:12.365721Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d232699cb6c87299","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.129:2379]}","request-path":"/0/members/d232699cb6c87299/attributes","cluster-id":"f2b9115890c3fc7f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T06:12:12.365982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T06:12:12.366048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T06:12:12.366095Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:12:12.366343Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T06:12:12.366425Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T06:12:12.367181Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:12:12.367321Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:12:12.367361Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:12:12.369302Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.129:2379"} {"level":"info","ts":"2026-09-09T06:12:12.37006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-09T06:12:14.452337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.185832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-09-09T06:12:14.452466Z","caller":"traceutil/trace.go:171","msg":"trace[2057695963] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"360.138945ms","start":"2026-09-09T06:12:14.09231Z","end":"2026-09-09T06:12:14.452449Z","steps":["trace[2057695963] 'process raft request' (duration: 172.277342ms)","trace[2057695963] 'compare' (duration: 187.00893ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:12:14.45256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:12:14.092286Z","time spent":"360.224816ms","remote":"127.0.0.1:54256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:12:14.823339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.678155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-09-09T06:12:14.823682Z","caller":"traceutil/trace.go:171","msg":"trace[1775142199] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"365.495288ms","start":"2026-09-09T06:12:14.458154Z","end":"2026-09-09T06:12:14.823649Z","steps":["trace[1775142199] 'process raft request' (duration: 167.322936ms)","trace[1775142199] 'compare' (duration: 197.43916ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:12:14.823869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:12:14.458134Z","time spent":"365.62599ms","remote":"127.0.0.1:54256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:12:52.37726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.521777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-09T06:12:52.377391Z","caller":"traceutil/trace.go:171","msg":"trace[1318454259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"295.731454ms","start":"2026-09-09T06:12:52.081635Z","end":"2026-09-09T06:12:52.377366Z","steps":["trace[1318454259] 'range keys from in-memory index tree' (duration: 295.367323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:12:52.377263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.023731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:12:52.377529Z","caller":"traceutil/trace.go:171","msg":"trace[1166532904] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:529; }","duration":"554.36705ms","start":"2026-09-09T06:12:51.823139Z","end":"2026-09-09T06:12:52.377506Z","steps":["trace[1166532904] 'range keys from in-memory index tree' (duration: 553.913758ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:12:52.377626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:12:51.82311Z","time spent":"554.497514ms","remote":"127.0.0.1:54272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-09-09T06:12:52.485345Z","caller":"traceutil/trace.go:171","msg":"trace[1395345642] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"102.961168ms","start":"2026-09-09T06:12:52.38235Z","end":"2026-09-09T06:12:52.485311Z","steps":["trace[1395345642] 'process raft request' (duration: 102.709011ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.938247Z","caller":"traceutil/trace.go:171","msg":"trace[241850500] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"203.244439ms","start":"2026-09-09T06:12:52.734967Z","end":"2026-09-09T06:12:52.938211Z","steps":["trace[241850500] 'process raft request' (duration: 203.053444ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.946471Z","caller":"traceutil/trace.go:171","msg":"trace[144374207] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"195.839691ms","start":"2026-09-09T06:12:52.750598Z","end":"2026-09-09T06:12:52.946438Z","steps":["trace[144374207] 'process raft request' (duration: 195.503822ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.946674Z","caller":"traceutil/trace.go:171","msg":"trace[1347849774] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"207.138529ms","start":"2026-09-09T06:12:52.739522Z","end":"2026-09-09T06:12:52.94666Z","steps":["trace[1347849774] 'process raft request' (duration: 206.451609ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.946788Z","caller":"traceutil/trace.go:171","msg":"trace[335448273] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"183.689601ms","start":"2026-09-09T06:12:52.763086Z","end":"2026-09-09T06:12:52.946776Z","steps":["trace[335448273] 'process raft request' (duration: 183.240398ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.946813Z","caller":"traceutil/trace.go:171","msg":"trace[1560971264] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:544; }","duration":"175.928103ms","start":"2026-09-09T06:12:52.770862Z","end":"2026-09-09T06:12:52.94679Z","steps":["trace[1560971264] 'read index received' (duration: 167.215139ms)","trace[1560971264] 'applied index is now lower than readState.Index' (duration: 8.711684ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:12:52.946891Z","caller":"traceutil/trace.go:171","msg":"trace[851634493] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"190.827651ms","start":"2026-09-09T06:12:52.756051Z","end":"2026-09-09T06:12:52.946879Z","steps":["trace[851634493] 'process raft request' (duration: 190.171732ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947014Z","caller":"traceutil/trace.go:171","msg":"trace[1464337123] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"186.056237ms","start":"2026-09-09T06:12:52.760947Z","end":"2026-09-09T06:12:52.947004Z","steps":["trace[1464337123] 'process raft request' (duration: 185.331637ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:12:52.947039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.146769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:12:52.94709Z","caller":"traceutil/trace.go:171","msg":"trace[1741363281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"176.268422ms","start":"2026-09-09T06:12:52.770807Z","end":"2026-09-09T06:12:52.947075Z","steps":["trace[1741363281] 'agreement among raft nodes before linearized reading' (duration: 176.101078ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947166Z","caller":"traceutil/trace.go:171","msg":"trace[17347246] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"152.436595ms","start":"2026-09-09T06:12:52.794692Z","end":"2026-09-09T06:12:52.947128Z","steps":["trace[17347246] 'process raft request' (duration: 151.837458ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947273Z","caller":"traceutil/trace.go:171","msg":"trace[1111404282] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"176.055577ms","start":"2026-09-09T06:12:52.771206Z","end":"2026-09-09T06:12:52.947262Z","steps":["trace[1111404282] 'process raft request' (duration: 175.205553ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947372Z","caller":"traceutil/trace.go:171","msg":"trace[1527475740] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"172.277841ms","start":"2026-09-09T06:12:52.775084Z","end":"2026-09-09T06:12:52.947362Z","steps":["trace[1527475740] 'process raft request' (duration: 171.390996ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947476Z","caller":"traceutil/trace.go:171","msg":"trace[204052926] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"135.253043ms","start":"2026-09-09T06:12:52.812213Z","end":"2026-09-09T06:12:52.947466Z","steps":["trace[204052926] 'process raft request' (duration: 134.43727ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:52.947567Z","caller":"traceutil/trace.go:171","msg":"trace[630419399] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"152.355633ms","start":"2026-09-09T06:12:52.795202Z","end":"2026-09-09T06:12:52.947558Z","steps":["trace[630419399] 'process raft request' (duration: 151.386516ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:59.316641Z","caller":"traceutil/trace.go:171","msg":"trace[1673280588] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"105.826278ms","start":"2026-09-09T06:12:59.210685Z","end":"2026-09-09T06:12:59.316512Z","steps":["trace[1673280588] 'read index received' (duration: 96.7868ms)","trace[1673280588] 'applied index is now lower than readState.Index' (duration: 9.038267ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:12:59.316853Z","caller":"traceutil/trace.go:171","msg":"trace[1824054595] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"125.963125ms","start":"2026-09-09T06:12:59.190788Z","end":"2026-09-09T06:12:59.316751Z","steps":["trace[1824054595] 'process raft request' (duration: 124.367787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:12:59.317152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.433055ms","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-09-09T06:12:59.317204Z","caller":"traceutil/trace.go:171","msg":"trace[859854706] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"106.508318ms","start":"2026-09-09T06:12:59.21068Z","end":"2026-09-09T06:12:59.317189Z","steps":["trace[859854706] 'agreement among raft nodes before linearized reading' (duration: 106.035434ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:59.503517Z","caller":"traceutil/trace.go:171","msg":"trace[28418584] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"181.416999ms","start":"2026-09-09T06:12:59.322048Z","end":"2026-09-09T06:12:59.503465Z","steps":["trace[28418584] 'process raft request' (duration: 125.865422ms)","trace[28418584] 'compare' (duration: 55.31961ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:12:59.518466Z","caller":"traceutil/trace.go:171","msg":"trace[1130333205] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"124.189442ms","start":"2026-09-09T06:12:59.394253Z","end":"2026-09-09T06:12:59.518442Z","steps":["trace[1130333205] 'process raft request' (duration: 124.045138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:00.00528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.306747ms","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-09-09T06:13:00.005426Z","caller":"traceutil/trace.go:171","msg":"trace[714289398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"206.504213ms","start":"2026-09-09T06:12:59.798901Z","end":"2026-09-09T06:13:00.005405Z","steps":["trace[714289398] 'range keys from in-memory index tree' (duration: 206.08964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:00.005495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.899781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qxwn2\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-09T06:13:00.005577Z","caller":"traceutil/trace.go:171","msg":"trace[1298170328] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qxwn2; range_end:; response_count:1; response_revision:640; }","duration":"328.020405ms","start":"2026-09-09T06:12:59.677535Z","end":"2026-09-09T06:13:00.005556Z","steps":["trace[1298170328] 'range keys from in-memory index tree' (duration: 327.714826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:00.005573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.479599ms","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-09-09T06:13:00.005678Z","caller":"traceutil/trace.go:171","msg":"trace[819312401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"213.635964ms","start":"2026-09-09T06:12:59.792017Z","end":"2026-09-09T06:13:00.005653Z","steps":["trace[819312401] 'range keys from in-memory index tree' (duration: 213.310104ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:00.005614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:12:59.677516Z","time spent":"328.089867ms","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-qxwn2\" "} {"level":"info","ts":"2026-09-09T06:13:00.115013Z","caller":"traceutil/trace.go:171","msg":"trace[442903252] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"176.862707ms","start":"2026-09-09T06:12:59.938128Z","end":"2026-09-09T06:13:00.114991Z","steps":["trace[442903252] 'process raft request' (duration: 175.98291ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:00.120248Z","caller":"traceutil/trace.go:171","msg":"trace[1238015426] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"109.635294ms","start":"2026-09-09T06:13:00.01059Z","end":"2026-09-09T06:13:00.120225Z","steps":["trace[1238015426] 'process raft request' (duration: 109.430708ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:00.12027Z","caller":"traceutil/trace.go:171","msg":"trace[1570404665] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"109.405977ms","start":"2026-09-09T06:13:00.010831Z","end":"2026-09-09T06:13:00.120237Z","steps":["trace[1570404665] 'process raft request' (duration: 109.300444ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:16.740327Z","caller":"traceutil/trace.go:171","msg":"trace[542526411] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"128.859697ms","start":"2026-09-09T06:13:16.611446Z","end":"2026-09-09T06:13:16.740306Z","steps":["trace[542526411] 'process raft request' (duration: 128.729263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:16.947848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.537305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fcxz6\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-09T06:13:16.947911Z","caller":"traceutil/trace.go:171","msg":"trace[2041373124] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fcxz6; range_end:; response_count:1; response_revision:807; }","duration":"152.652069ms","start":"2026-09-09T06:13:16.795244Z","end":"2026-09-09T06:13:16.947896Z","steps":["trace[2041373124] 'range keys from in-memory index tree' (duration: 152.384271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.476708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.950555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:14:36.477207Z","caller":"traceutil/trace.go:171","msg":"trace[660751334] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"498.392845ms","start":"2026-09-09T06:14:35.978781Z","end":"2026-09-09T06:14:36.477174Z","steps":["trace[660751334] 'process raft request' (duration: 79.874848ms)","trace[660751334] 'compare' (duration: 417.788767ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:14:36.477376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:14:35.978757Z","time spent":"498.52865ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:14:36.477426Z","caller":"traceutil/trace.go:171","msg":"trace[457503875] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1957; }","duration":"471.631084ms","start":"2026-09-09T06:14:36.005772Z","end":"2026-09-09T06:14:36.477403Z","steps":["trace[457503875] 'read index received' (duration: 52.759503ms)","trace[457503875] 'applied index is now lower than readState.Index' (duration: 418.870371ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:14:36.47754Z","caller":"traceutil/trace.go:171","msg":"trace[612320336] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"482.18695ms","start":"2026-09-09T06:14:35.995338Z","end":"2026-09-09T06:14:36.477525Z","steps":["trace[612320336] 'process raft request' (duration: 481.484722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.477631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:14:35.995321Z","time spent":"482.261183ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:14:36.477609Z","caller":"traceutil/trace.go:171","msg":"trace[1637690095] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"201.727724ms","start":"2026-09-09T06:14:36.275847Z","end":"2026-09-09T06:14:36.477574Z","steps":["trace[1637690095] 'process raft request' (duration: 201.508585ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.477919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.140785ms","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-09-09T06:14:36.477968Z","caller":"traceutil/trace.go:171","msg":"trace[197827558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1890; }","duration":"472.230119ms","start":"2026-09-09T06:14:36.005724Z","end":"2026-09-09T06:14:36.477954Z","steps":["trace[197827558] 'agreement among raft nodes before linearized reading' (duration: 472.049991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.47799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.324995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-09T06:14:36.478006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:14:36.005708Z","time spent":"472.288771ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-09T06:14:36.47804Z","caller":"traceutil/trace.go:171","msg":"trace[320944165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1890; }","duration":"124.414179ms","start":"2026-09-09T06:14:36.353614Z","end":"2026-09-09T06:14:36.478028Z","steps":["trace[320944165] 'agreement among raft nodes before linearized reading' (duration: 124.338566ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.478029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.907799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ddd955f4-6f5e-4e7a-bcaf-320e592a5d8e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-09T06:14:36.478091Z","caller":"traceutil/trace.go:171","msg":"trace[484902215] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ddd955f4-6f5e-4e7a-bcaf-320e592a5d8e; range_end:; response_count:1; response_revision:1890; }","duration":"293.022324ms","start":"2026-09-09T06:14:36.185052Z","end":"2026-09-09T06:14:36.478075Z","steps":["trace[484902215] 'agreement among raft nodes before linearized reading' (duration: 292.800675ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:14:36.624196Z","caller":"traceutil/trace.go:171","msg":"trace[871261311] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"138.384114ms","start":"2026-09-09T06:14:36.485786Z","end":"2026-09-09T06:14:36.62417Z","steps":["trace[871261311] 'process raft request' (duration: 138.316661ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:14:36.624206Z","caller":"traceutil/trace.go:171","msg":"trace[2104247078] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"141.635635ms","start":"2026-09-09T06:14:36.482531Z","end":"2026-09-09T06:14:36.624167Z","steps":["trace[2104247078] 'process raft request' (duration: 112.448196ms)","trace[2104247078] 'compare' (duration: 28.989081ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:14:36.979878Z","caller":"traceutil/trace.go:171","msg":"trace[349774032] linearizableReadLoop","detail":"{readStateIndex:1964; appliedIndex:1963; }","duration":"328.099952ms","start":"2026-09-09T06:14:36.651761Z","end":"2026-09-09T06:14:36.979861Z","steps":["trace[349774032] 'read index received' (duration: 327.954707ms)","trace[349774032] 'applied index is now lower than readState.Index' (duration: 144.585µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:14:36.97997Z","caller":"traceutil/trace.go:171","msg":"trace[281018105] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"335.757952ms","start":"2026-09-09T06:14:36.644197Z","end":"2026-09-09T06:14:36.979955Z","steps":["trace[281018105] 'process raft request' (duration: 335.554554ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.980099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.231161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T06:14:36.980116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.251617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-09T06:14:36.980115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:14:36.644175Z","time spent":"335.853936ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:14:36.980131Z","caller":"traceutil/trace.go:171","msg":"trace[692412025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1894; }","duration":"219.297284ms","start":"2026-09-09T06:14:36.760823Z","end":"2026-09-09T06:14:36.980121Z","steps":["trace[692412025] 'agreement among raft nodes before linearized reading' (duration: 219.243742ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:14:36.980142Z","caller":"traceutil/trace.go:171","msg":"trace[823186838] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1894; }","duration":"277.317069ms","start":"2026-09-09T06:14:36.702817Z","end":"2026-09-09T06:14:36.980134Z","steps":["trace[823186838] 'agreement among raft nodes before linearized reading' (duration: 277.208985ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.980359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.60394ms","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-09-09T06:14:36.98039Z","caller":"traceutil/trace.go:171","msg":"trace[95426236] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1894; }","duration":"251.662812ms","start":"2026-09-09T06:14:36.728719Z","end":"2026-09-09T06:14:36.980381Z","steps":["trace[95426236] 'agreement among raft nodes before linearized reading' (duration: 251.59012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.980704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.932626ms","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-09-09T06:14:36.980759Z","caller":"traceutil/trace.go:171","msg":"trace[1052470255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1894; }","duration":"329.019399ms","start":"2026-09-09T06:14:36.651725Z","end":"2026-09-09T06:14:36.980745Z","steps":["trace[1052470255] 'agreement among raft nodes before linearized reading' (duration: 328.249868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:36.980805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:14:36.65171Z","time spent":"329.084062ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-09T06:14:45.157331Z","caller":"traceutil/trace.go:171","msg":"trace[1410439066] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"105.539537ms","start":"2026-09-09T06:14:45.051747Z","end":"2026-09-09T06:14:45.157287Z","steps":["trace[1410439066] 'process raft request' (duration: 80.893151ms)","trace[1410439066] 'compare' (duration: 24.113225ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:15:11.131198Z","caller":"traceutil/trace.go:171","msg":"trace[298175993] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"106.450658ms","start":"2026-09-09T06:15:11.024719Z","end":"2026-09-09T06:15:11.131169Z","steps":["trace[298175993] 'process raft request' (duration: 106.233039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:11.338307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.486629ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-09T06:15:11.338643Z","caller":"traceutil/trace.go:171","msg":"trace[1894478509] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"150.719083ms","start":"2026-09-09T06:15:11.187896Z","end":"2026-09-09T06:15:11.338615Z","steps":["trace[1894478509] 'read index received' (duration: 41.662µs)","trace[1894478509] 'applied index is now lower than readState.Index' (duration: 150.674301ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:15:11.338904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.994455ms","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-09-09T06:15:11.338949Z","caller":"traceutil/trace.go:171","msg":"trace[1111037316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2132; }","duration":"151.089689ms","start":"2026-09-09T06:15:11.187848Z","end":"2026-09-09T06:15:11.338938Z","steps":["trace[1111037316] 'agreement among raft nodes before linearized reading' (duration: 150.88386ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:11.432889Z","caller":"traceutil/trace.go:171","msg":"trace[2073402173] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"105.593592ms","start":"2026-09-09T06:15:11.327273Z","end":"2026-09-09T06:15:11.432867Z","steps":["trace[2073402173] 'process raft request' (duration: 84.621668ms)","trace[2073402173] 'compare' (duration: 20.758795ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:15:11.433288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.169832ms","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-09-09T06:15:11.433288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.739099ms","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-09-09T06:15:11.433454Z","caller":"traceutil/trace.go:171","msg":"trace[1393370041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"123.947487ms","start":"2026-09-09T06:15:11.309491Z","end":"2026-09-09T06:15:11.433438Z","steps":["trace[1393370041] 'agreement among raft nodes before linearized reading' (duration: 123.631384ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:11.433354Z","caller":"traceutil/trace.go:171","msg":"trace[681249567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2134; }","duration":"122.286358ms","start":"2026-09-09T06:15:11.31105Z","end":"2026-09-09T06:15:11.433336Z","steps":["trace[681249567] 'agreement among raft nodes before linearized reading' (duration: 121.953704ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:11.433407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.994541ms","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-09-09T06:15:11.434022Z","caller":"traceutil/trace.go:171","msg":"trace[1370512337] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"202.738612ms","start":"2026-09-09T06:15:11.231252Z","end":"2026-09-09T06:15:11.43399Z","steps":["trace[1370512337] 'agreement among raft nodes before linearized reading' (duration: 201.659047ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:12.381807Z","caller":"traceutil/trace.go:171","msg":"trace[1633335499] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"174.027009ms","start":"2026-09-09T06:15:12.207757Z","end":"2026-09-09T06:15:12.381784Z","steps":["trace[1633335499] 'process raft request' (duration: 173.889143ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:12.69404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.125659ms","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-09-09T06:15:12.694134Z","caller":"traceutil/trace.go:171","msg":"trace[256482471] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2137; }","duration":"253.271985ms","start":"2026-09-09T06:15:12.440843Z","end":"2026-09-09T06:15:12.694115Z","steps":["trace[256482471] 'range keys from in-memory index tree' (duration: 252.92961ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:13.036578Z","caller":"traceutil/trace.go:171","msg":"trace[547620308] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"417.059289ms","start":"2026-09-09T06:15:12.619493Z","end":"2026-09-09T06:15:13.036552Z","steps":["trace[547620308] 'process raft request' (duration: 416.85768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:13.036731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:15:12.619458Z","time spent":"417.189984ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:15:13.079327Z","caller":"traceutil/trace.go:171","msg":"trace[565408302] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2215; }","duration":"319.553182ms","start":"2026-09-09T06:15:12.759745Z","end":"2026-09-09T06:15:13.079298Z","steps":["trace[565408302] 'read index received' (duration: 276.779706ms)","trace[565408302] 'applied index is now lower than readState.Index' (duration: 42.771826ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:15:13.079377Z","caller":"traceutil/trace.go:171","msg":"trace[1923363412] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"437.67958ms","start":"2026-09-09T06:15:12.641662Z","end":"2026-09-09T06:15:13.079341Z","steps":["trace[1923363412] 'process raft request' (duration: 437.488542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:13.079621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.773961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:15:13.079892Z","caller":"traceutil/trace.go:171","msg":"trace[403581488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"320.151017ms","start":"2026-09-09T06:15:12.759721Z","end":"2026-09-09T06:15:13.079872Z","steps":["trace[403581488] 'agreement among raft nodes before linearized reading' (duration: 319.73505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:13.07996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.824866ms","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-09-09T06:15:13.080039Z","caller":"traceutil/trace.go:171","msg":"trace[391586305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2139; }","duration":"263.014374ms","start":"2026-09-09T06:15:12.817006Z","end":"2026-09-09T06:15:13.080021Z","steps":["trace[391586305] 'agreement among raft nodes before linearized reading' (duration: 262.785165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:13.080163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:15:12.759612Z","time spent":"320.390827ms","remote":"127.0.0.1:54166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-09T06:15:13.080253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:15:12.641634Z","time spent":"438.206402ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:15:13.356157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.027129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:15:13.356293Z","caller":"traceutil/trace.go:171","msg":"trace[685976265] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"271.653269ms","start":"2026-09-09T06:15:13.084615Z","end":"2026-09-09T06:15:13.356269Z","steps":["trace[685976265] 'process raft request' (duration: 77.434762ms)","trace[685976265] 'compare' (duration: 193.926115ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:16:25.050851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.495429ms","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-09-09T06:16:25.050919Z","caller":"traceutil/trace.go:171","msg":"trace[1242921303] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2628; }","duration":"186.5866ms","start":"2026-09-09T06:16:24.86431Z","end":"2026-09-09T06:16:25.050897Z","steps":["trace[1242921303] 'count revisions from in-memory index tree' (duration: 186.271436ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:16:54.873223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.537096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:16:54.873341Z","caller":"traceutil/trace.go:171","msg":"trace[1039112523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2794; }","duration":"113.73486ms","start":"2026-09-09T06:16:54.759582Z","end":"2026-09-09T06:16:54.873316Z","steps":["trace[1039112523] 'range keys from in-memory index tree' (duration: 113.435945ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:17:00.125441Z","caller":"traceutil/trace.go:171","msg":"trace[326093550] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"167.338748ms","start":"2026-09-09T06:16:59.95807Z","end":"2026-09-09T06:17:00.125409Z","steps":["trace[326093550] 'process raft request' (duration: 161.628614ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:31.650143Z","caller":"traceutil/trace.go:171","msg":"trace[1098169619] linearizableReadLoop","detail":"{readStateIndex:5120; appliedIndex:5119; }","duration":"157.995277ms","start":"2026-09-09T06:21:31.492124Z","end":"2026-09-09T06:21:31.650119Z","steps":["trace[1098169619] 'read index received' (duration: 157.744528ms)","trace[1098169619] 'applied index is now lower than readState.Index' (duration: 249.329µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:31.65018Z","caller":"traceutil/trace.go:171","msg":"trace[1786040322] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"168.364037ms","start":"2026-09-09T06:21:31.481778Z","end":"2026-09-09T06:21:31.650142Z","steps":["trace[1786040322] 'process raft request' (duration: 168.18218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.650428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.246996ms","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-09-09T06:21:31.650464Z","caller":"traceutil/trace.go:171","msg":"trace[1988167382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4933; }","duration":"158.34725ms","start":"2026-09-09T06:21:31.492106Z","end":"2026-09-09T06:21:31.650453Z","steps":["trace[1988167382] 'agreement among raft nodes before linearized reading' (duration: 158.151773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.650521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.504779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-09T06:21:31.650593Z","caller":"traceutil/trace.go:171","msg":"trace[439435965] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4933; }","duration":"157.602193ms","start":"2026-09-09T06:21:31.492971Z","end":"2026-09-09T06:21:31.650573Z","steps":["trace[439435965] 'agreement among raft nodes before linearized reading' (duration: 157.325453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.650618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.714321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:21:31.650644Z","caller":"traceutil/trace.go:171","msg":"trace[855256327] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4933; }","duration":"129.768633ms","start":"2026-09-09T06:21:31.520868Z","end":"2026-09-09T06:21:31.650637Z","steps":["trace[855256327] 'agreement among raft nodes before linearized reading' (duration: 129.716581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.651502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.133373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-09T06:21:31.651582Z","caller":"traceutil/trace.go:171","msg":"trace[2103921329] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4933; }","duration":"128.249497ms","start":"2026-09-09T06:21:31.523315Z","end":"2026-09-09T06:21:31.651564Z","steps":["trace[2103921329] 'agreement among raft nodes before linearized reading' (duration: 127.262861ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.911114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.89423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:21:31.911216Z","caller":"traceutil/trace.go:171","msg":"trace[375515741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4934; }","duration":"153.045165ms","start":"2026-09-09T06:21:31.758147Z","end":"2026-09-09T06:21:31.911193Z","steps":["trace[375515741] 'range keys from in-memory index tree' (duration: 152.823638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.911235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.719861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:21:31.912089Z","caller":"traceutil/trace.go:171","msg":"trace[1594477603] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:4934; }","duration":"145.571472ms","start":"2026-09-09T06:21:31.766483Z","end":"2026-09-09T06:21:31.912054Z","steps":["trace[1594477603] 'count revisions from in-memory index tree' (duration: 144.68531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.911169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.280523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-09-09T06:21:31.912211Z","caller":"traceutil/trace.go:171","msg":"trace[863137245] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4934; }","duration":"190.360233ms","start":"2026-09-09T06:21:31.721799Z","end":"2026-09-09T06:21:31.912159Z","steps":["trace[863137245] 'range keys from in-memory index tree' (duration: 189.093066ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.911674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.37816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-09T06:21:31.912499Z","caller":"traceutil/trace.go:171","msg":"trace[2037124867] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4934; }","duration":"171.280703ms","start":"2026-09-09T06:21:31.741185Z","end":"2026-09-09T06:21:31.912466Z","steps":["trace[2037124867] 'range keys from in-memory index tree' (duration: 170.189434ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:31.911848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.689055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-09-09T06:21:31.912666Z","caller":"traceutil/trace.go:171","msg":"trace[1665597707] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4934; }","duration":"167.704613ms","start":"2026-09-09T06:21:31.744944Z","end":"2026-09-09T06:21:31.912649Z","steps":["trace[1665597707] 'range keys from in-memory index tree' (duration: 166.581772ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:38.135819Z","caller":"traceutil/trace.go:171","msg":"trace[1912142590] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"153.323374ms","start":"2026-09-09T06:21:37.982463Z","end":"2026-09-09T06:21:38.135786Z","steps":["trace[1912142590] 'process raft request' (duration: 135.989287ms)","trace[1912142590] 'compare' (duration: 17.185522ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:38.36091Z","caller":"traceutil/trace.go:171","msg":"trace[1773868736] linearizableReadLoop","detail":"{readStateIndex:5231; appliedIndex:5230; }","duration":"165.43857ms","start":"2026-09-09T06:21:38.195438Z","end":"2026-09-09T06:21:38.360877Z","steps":["trace[1773868736] 'read index received' (duration: 157.431065ms)","trace[1773868736] 'applied index is now lower than readState.Index' (duration: 8.004635ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:21:38.361172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.717579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1c81f9cb-c8ea-48d7-bbbc-36eeb6bbf597\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-09T06:21:38.361228Z","caller":"traceutil/trace.go:171","msg":"trace[1306419114] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1c81f9cb-c8ea-48d7-bbbc-36eeb6bbf597; range_end:; response_count:1; response_revision:5042; }","duration":"165.849335ms","start":"2026-09-09T06:21:38.195366Z","end":"2026-09-09T06:21:38.361215Z","steps":["trace[1306419114] 'agreement among raft nodes before linearized reading' (duration: 165.619467ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:38.361417Z","caller":"traceutil/trace.go:171","msg":"trace[633511983] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"202.226921ms","start":"2026-09-09T06:21:38.158886Z","end":"2026-09-09T06:21:38.361113Z","steps":["trace[633511983] 'process raft request' (duration: 194.001079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:38.591878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.76646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:21:38.592364Z","caller":"traceutil/trace.go:171","msg":"trace[966340485] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"168.146849ms","start":"2026-09-09T06:21:38.424153Z","end":"2026-09-09T06:21:38.5923Z","steps":["trace[966340485] 'process raft request' (duration: 167.831557ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:38.592584Z","caller":"traceutil/trace.go:171","msg":"trace[1074773309] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"174.355717ms","start":"2026-09-09T06:21:38.418192Z","end":"2026-09-09T06:21:38.592548Z","steps":["trace[1074773309] 'process raft request' (duration: 59.797497ms)","trace[1074773309] 'compare' (duration: 113.613225ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:38.593062Z","caller":"traceutil/trace.go:171","msg":"trace[299877686] linearizableReadLoop","detail":"{readStateIndex:5234; appliedIndex:5232; }","duration":"152.712292ms","start":"2026-09-09T06:21:38.440303Z","end":"2026-09-09T06:21:38.593015Z","steps":["trace[299877686] 'read index received' (duration: 37.862142ms)","trace[299877686] 'applied index is now lower than readState.Index' (duration: 114.84591ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:21:38.593563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.235531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-09T06:21:38.593592Z","caller":"traceutil/trace.go:171","msg":"trace[589477315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5046; }","duration":"153.347135ms","start":"2026-09-09T06:21:38.440238Z","end":"2026-09-09T06:21:38.593585Z","steps":["trace[589477315] 'agreement among raft nodes before linearized reading' (duration: 152.93789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:38.624338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.341883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-09T06:21:38.624414Z","caller":"traceutil/trace.go:171","msg":"trace[224143414] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5049; }","duration":"129.433826ms","start":"2026-09-09T06:21:38.49496Z","end":"2026-09-09T06:21:38.624393Z","steps":["trace[224143414] 'agreement among raft nodes before linearized reading' (duration: 129.168176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.183789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.228899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:21:39.183997Z","caller":"traceutil/trace.go:171","msg":"trace[670235159] linearizableReadLoop","detail":"{readStateIndex:5239; appliedIndex:5238; }","duration":"424.800813ms","start":"2026-09-09T06:21:38.759141Z","end":"2026-09-09T06:21:39.183942Z","steps":["trace[670235159] 'read index received' (duration: 153.268152ms)","trace[670235159] 'applied index is now lower than readState.Index' (duration: 271.530901ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:39.184371Z","caller":"traceutil/trace.go:171","msg":"trace[398641517] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"550.292485ms","start":"2026-09-09T06:21:38.634063Z","end":"2026-09-09T06:21:39.184355Z","steps":["trace[398641517] 'process raft request' (duration: 278.320288ms)","trace[398641517] 'compare' (duration: 270.932579ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:21:39.184442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.634046Z","time spent":"550.358037ms","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13278,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:21:39.184459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.28158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:21:39.184556Z","caller":"traceutil/trace.go:171","msg":"trace[405431770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5050; }","duration":"425.434187ms","start":"2026-09-09T06:21:38.759096Z","end":"2026-09-09T06:21:39.18453Z","steps":["trace[405431770] 'agreement among raft nodes before linearized reading' (duration: 425.269341ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.184611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.759067Z","time spent":"425.53098ms","remote":"127.0.0.1:54166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-09T06:21:39.205137Z","caller":"traceutil/trace.go:171","msg":"trace[262321699] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"382.157937ms","start":"2026-09-09T06:21:38.822945Z","end":"2026-09-09T06:21:39.205103Z","steps":["trace[262321699] 'process raft request' (duration: 382.103725ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:39.2053Z","caller":"traceutil/trace.go:171","msg":"trace[786570075] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"391.630905ms","start":"2026-09-09T06:21:38.813636Z","end":"2026-09-09T06:21:39.205267Z","steps":["trace[786570075] 'process raft request' (duration: 391.195929ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.205354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.822924Z","time spent":"382.320242ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:21:39.205412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.813612Z","time spent":"391.739299ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:21:39.273364Z","caller":"traceutil/trace.go:171","msg":"trace[1130515712] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"349.062581ms","start":"2026-09-09T06:21:38.924262Z","end":"2026-09-09T06:21:39.273324Z","steps":["trace[1130515712] 'process raft request' (duration: 348.77224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.27374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.924224Z","time spent":"349.367903ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:21:39.274513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.231319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T06:21:39.27459Z","caller":"traceutil/trace.go:171","msg":"trace[894008535] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:5057; }","duration":"444.365574ms","start":"2026-09-09T06:21:38.830204Z","end":"2026-09-09T06:21:39.27457Z","steps":["trace[894008535] 'agreement among raft nodes before linearized reading' (duration: 443.98995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.274663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:38.830188Z","time spent":"444.458608ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-09-09T06:21:39.475036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.703126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1c81f9cb-c8ea-48d7-bbbc-36eeb6bbf597\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-09-09T06:21:39.47512Z","caller":"traceutil/trace.go:171","msg":"trace[946396458] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1c81f9cb-c8ea-48d7-bbbc-36eeb6bbf597; range_end:; response_count:1; response_revision:5057; }","duration":"108.847012ms","start":"2026-09-09T06:21:39.366252Z","end":"2026-09-09T06:21:39.475099Z","steps":["trace[946396458] 'range keys from in-memory index tree' (duration: 108.511249ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:39.475556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.921171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-09T06:21:39.475633Z","caller":"traceutil/trace.go:171","msg":"trace[1151182195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5057; }","duration":"144.049696ms","start":"2026-09-09T06:21:39.331566Z","end":"2026-09-09T06:21:39.475615Z","steps":["trace[1151182195] 'range keys from in-memory index tree' (duration: 143.781856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:41.253341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.374351ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-09T06:21:51.899153Z","caller":"traceutil/trace.go:171","msg":"trace[752069958] linearizableReadLoop","detail":"{readStateIndex:5395; appliedIndex:5394; }","duration":"342.195675ms","start":"2026-09-09T06:21:51.556931Z","end":"2026-09-09T06:21:51.899127Z","steps":["trace[752069958] 'read index received' (duration: 341.904434ms)","trace[752069958] 'applied index is now lower than readState.Index' (duration: 289.801µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:51.899238Z","caller":"traceutil/trace.go:171","msg":"trace[123881899] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"351.855431ms","start":"2026-09-09T06:21:51.547346Z","end":"2026-09-09T06:21:51.899202Z","steps":["trace[123881899] 'process raft request' (duration: 351.581281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:51.899358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:51.547326Z","time spent":"351.971286ms","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10667,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:21:51.899412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.537171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-09-09T06:21:51.899411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.467974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-09T06:21:51.899471Z","caller":"traceutil/trace.go:171","msg":"trace[1774101351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5201; }","duration":"298.648185ms","start":"2026-09-09T06:21:51.600807Z","end":"2026-09-09T06:21:51.899455Z","steps":["trace[1774101351] 'agreement among raft nodes before linearized reading' (duration: 298.472318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:51.899492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.282158ms","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-09-09T06:21:51.899482Z","caller":"traceutil/trace.go:171","msg":"trace[1894210238] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5201; }","duration":"342.558058ms","start":"2026-09-09T06:21:51.556904Z","end":"2026-09-09T06:21:51.899462Z","steps":["trace[1894210238] 'agreement among raft nodes before linearized reading' (duration: 342.354971ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:51.899515Z","caller":"traceutil/trace.go:171","msg":"trace[191499149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5201; }","duration":"132.31638ms","start":"2026-09-09T06:21:51.767193Z","end":"2026-09-09T06:21:51.899509Z","steps":["trace[191499149] 'agreement among raft nodes before linearized reading' (duration: 132.253037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:51.899525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:51.556889Z","time spent":"342.6284ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-09T06:21:51.899688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.585447ms","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-09-09T06:21:51.899728Z","caller":"traceutil/trace.go:171","msg":"trace[43618640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5201; }","duration":"136.66429ms","start":"2026-09-09T06:21:51.763053Z","end":"2026-09-09T06:21:51.899717Z","steps":["trace[43618640] 'agreement among raft nodes before linearized reading' (duration: 136.521845ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.058482Z","caller":"traceutil/trace.go:171","msg":"trace[830184250] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"154.793332ms","start":"2026-09-09T06:21:51.903669Z","end":"2026-09-09T06:21:52.058462Z","steps":["trace[830184250] 'process raft request' (duration: 129.536648ms)","trace[830184250] 'compare' (duration: 25.16689ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.098937Z","caller":"traceutil/trace.go:171","msg":"trace[197590000] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"189.742103ms","start":"2026-09-09T06:21:51.909168Z","end":"2026-09-09T06:21:52.09891Z","steps":["trace[197590000] 'process raft request' (duration: 189.545435ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.099314Z","caller":"traceutil/trace.go:171","msg":"trace[1006606953] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"190.022053ms","start":"2026-09-09T06:21:51.909256Z","end":"2026-09-09T06:21:52.099278Z","steps":["trace[1006606953] 'process raft request' (duration: 189.591847ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.09977Z","caller":"traceutil/trace.go:171","msg":"trace[284427736] linearizableReadLoop","detail":"{readStateIndex:5403; appliedIndex:5395; }","duration":"183.200042ms","start":"2026-09-09T06:21:51.916549Z","end":"2026-09-09T06:21:52.099749Z","steps":["trace[284427736] 'read index received' (duration: 116.717764ms)","trace[284427736] 'applied index is now lower than readState.Index' (duration: 66.481078ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.099817Z","caller":"traceutil/trace.go:171","msg":"trace[321266630] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"190.48048ms","start":"2026-09-09T06:21:51.909327Z","end":"2026-09-09T06:21:52.099808Z","steps":["trace[321266630] 'process raft request' (duration: 189.843736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:52.099892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.314246ms","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-09-09T06:21:52.099946Z","caller":"traceutil/trace.go:171","msg":"trace[1056505075] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5209; }","duration":"183.422819ms","start":"2026-09-09T06:21:51.916508Z","end":"2026-09-09T06:21:52.099931Z","steps":["trace[1056505075] 'agreement among raft nodes before linearized reading' (duration: 183.322736ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.100088Z","caller":"traceutil/trace.go:171","msg":"trace[1548535457] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"189.036987ms","start":"2026-09-09T06:21:51.911041Z","end":"2026-09-09T06:21:52.100078Z","steps":["trace[1548535457] 'process raft request' (duration: 188.601171ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.10022Z","caller":"traceutil/trace.go:171","msg":"trace[225972334] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"188.487016ms","start":"2026-09-09T06:21:51.911716Z","end":"2026-09-09T06:21:52.100203Z","steps":["trace[225972334] 'process raft request' (duration: 187.983528ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.099775Z","caller":"traceutil/trace.go:171","msg":"trace[994197617] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"190.389627ms","start":"2026-09-09T06:21:51.909352Z","end":"2026-09-09T06:21:52.099741Z","steps":["trace[994197617] 'process raft request' (duration: 190.119027ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.1032Z","caller":"traceutil/trace.go:171","msg":"trace[162322782] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"190.923296ms","start":"2026-09-09T06:21:51.909357Z","end":"2026-09-09T06:21:52.10028Z","steps":["trace[162322782] 'process raft request' (duration: 190.22027ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.319788Z","caller":"traceutil/trace.go:171","msg":"trace[954545706] linearizableReadLoop","detail":"{readStateIndex:5404; appliedIndex:5403; }","duration":"104.960481ms","start":"2026-09-09T06:21:52.214804Z","end":"2026-09-09T06:21:52.319764Z","steps":["trace[954545706] 'read index received' (duration: 104.68738ms)","trace[954545706] 'applied index is now lower than readState.Index' (duration: 272.171µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.319938Z","caller":"traceutil/trace.go:171","msg":"trace[241534985] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"105.692467ms","start":"2026-09-09T06:21:52.214224Z","end":"2026-09-09T06:21:52.319917Z","steps":["trace[241534985] 'process raft request' (duration: 105.332244ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:52.320051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.20697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"info","ts":"2026-09-09T06:21:52.320103Z","caller":"traceutil/trace.go:171","msg":"trace[838609796] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5210; }","duration":"105.311014ms","start":"2026-09-09T06:21:52.214778Z","end":"2026-09-09T06:21:52.320089Z","steps":["trace[838609796] 'agreement among raft nodes before linearized reading' (duration: 105.077825ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:52.502962Z","caller":"traceutil/trace.go:171","msg":"trace[589887480] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"126.150634ms","start":"2026-09-09T06:21:52.376776Z","end":"2026-09-09T06:21:52.502926Z","steps":["trace[589887480] 'process raft request' (duration: 34.643911ms)","trace[589887480] 'compare' (duration: 91.284125ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.853728Z","caller":"traceutil/trace.go:171","msg":"trace[1708211332] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"212.06948ms","start":"2026-09-09T06:21:52.641628Z","end":"2026-09-09T06:21:52.853697Z","steps":["trace[1708211332] 'process raft request' (duration: 118.301163ms)","trace[1708211332] 'compare' (duration: 93.649522ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.887571Z","caller":"traceutil/trace.go:171","msg":"trace[1327969207] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5406; }","duration":"160.621318ms","start":"2026-09-09T06:21:52.726925Z","end":"2026-09-09T06:21:52.887547Z","steps":["trace[1327969207] 'read index received' (duration: 33.00647ms)","trace[1327969207] 'applied index is now lower than readState.Index' (duration: 127.613948ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:21:52.88769Z","caller":"traceutil/trace.go:171","msg":"trace[1643775182] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"183.039507ms","start":"2026-09-09T06:21:52.704636Z","end":"2026-09-09T06:21:52.887676Z","steps":["trace[1643775182] 'process raft request' (duration: 182.773647ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:52.887865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.533312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:21:52.887923Z","caller":"traceutil/trace.go:171","msg":"trace[1501852094] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5214; }","duration":"128.625785ms","start":"2026-09-09T06:21:52.759282Z","end":"2026-09-09T06:21:52.887908Z","steps":["trace[1501852094] 'agreement among raft nodes before linearized reading' (duration: 128.533832ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:21:52.888198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.274562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-09T06:21:52.888244Z","caller":"traceutil/trace.go:171","msg":"trace[1615461235] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5214; }","duration":"161.366355ms","start":"2026-09-09T06:21:52.726866Z","end":"2026-09-09T06:21:52.888233Z","steps":["trace[1615461235] 'agreement among raft nodes before linearized reading' (duration: 160.993552ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:53.022732Z","caller":"traceutil/trace.go:171","msg":"trace[1053302762] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"129.428695ms","start":"2026-09-09T06:21:52.893285Z","end":"2026-09-09T06:21:53.022713Z","steps":["trace[1053302762] 'process raft request' (duration: 120.821497ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:21:53.061768Z","caller":"traceutil/trace.go:171","msg":"trace[2072305177] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"161.131428ms","start":"2026-09-09T06:21:52.90061Z","end":"2026-09-09T06:21:53.061741Z","steps":["trace[2072305177] 'process raft request' (duration: 160.92833ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:22:12.400272Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2889} {"level":"info","ts":"2026-09-09T06:22:12.482243Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2889,"took":"80.598632ms","hash":4036529309,"current-db-size-bytes":52195328,"current-db-size":"52 MB","current-db-size-in-use-bytes":27701248,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-09T06:22:12.482331Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4036529309,"revision":2889,"compact-revision":-1} {"level":"info","ts":"2026-09-09T06:22:45.091714Z","caller":"traceutil/trace.go:171","msg":"trace[858067058] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"140.549376ms","start":"2026-09-09T06:22:44.951135Z","end":"2026-09-09T06:22:45.091684Z","steps":["trace[858067058] 'process raft request' (duration: 140.334698ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:22:45.215785Z","caller":"traceutil/trace.go:171","msg":"trace[950527935] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"186.850099ms","start":"2026-09-09T06:22:45.028908Z","end":"2026-09-09T06:22:45.215758Z","steps":["trace[950527935] 'process raft request' (duration: 186.715964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:25:40.491442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.98783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:25:40.491539Z","caller":"traceutil/trace.go:171","msg":"trace[612314772] linearizableReadLoop","detail":"{readStateIndex:7114; appliedIndex:7113; }","duration":"171.395536ms","start":"2026-09-09T06:25:40.320129Z","end":"2026-09-09T06:25:40.491524Z","steps":["trace[612314772] 'read index received' (duration: 68.225943ms)","trace[612314772] 'applied index is now lower than readState.Index' (duration: 103.168213ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:25:40.491624Z","caller":"traceutil/trace.go:171","msg":"trace[698373140] transaction","detail":"{read_only:false; response_revision:6867; number_of_response:1; }","duration":"180.85629ms","start":"2026-09-09T06:25:40.310736Z","end":"2026-09-09T06:25:40.491593Z","steps":["trace[698373140] 'process raft request' (duration: 77.636266ms)","trace[698373140] 'compare' (duration: 102.751576ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:25:40.49172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.594159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-09T06:25:40.491757Z","caller":"traceutil/trace.go:171","msg":"trace[1856497532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6867; }","duration":"171.65811ms","start":"2026-09-09T06:25:40.320088Z","end":"2026-09-09T06:25:40.491746Z","steps":["trace[1856497532] 'agreement among raft nodes before linearized reading' (duration: 171.517768ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:27:12.407573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5364} {"level":"info","ts":"2026-09-09T06:27:12.530809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5364,"took":"121.753812ms","hash":3960419386,"current-db-size-bytes":52195328,"current-db-size":"52 MB","current-db-size-in-use-bytes":18808832,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-09T06:27:12.530895Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3960419386,"revision":5364,"compact-revision":2889}