{"level":"warn","ts":"2026-06-15T11:42:13.644387Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T11:42:13.644485Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-15T11:42:13.644549Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T11:42:13.644558Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-15T11:42:13.64458Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T11:42:13.645285Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-15T11:42:13.645366Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-15T11:42:13.692517Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"46.907143ms"} {"level":"info","ts":"2026-06-15T11:42:13.74547Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-15T11:42:13.745717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T11:42:13.745764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-15T11:42:13.745801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T11:42:13.745833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-15T11:42:13.745928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-15T11:42:13.779781Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T11:42:13.796658Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T11:42:13.797838Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-15T11:42:13.801311Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T11:42:13.802544Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:42:13.801888Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T11:42:13.802717Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:42:13.803063Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:42:13.810168Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T11:42:13.810414Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-15T11:42:13.810465Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-15T11:42:13.811396Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T11:42:13.81144Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T11:42:13.818899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-15T11:42:13.819061Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-15T11:42:14.74723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T11:42:14.747296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T11:42:14.747328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-15T11:42:14.747342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-15T11:42:14.747349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-15T11:42:14.747362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-15T11:42:14.747371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-15T11:42:14.748671Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:42:14.750659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T11:42:14.750685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:42:14.750718Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:42:14.75089Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T11:42:14.75091Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T11:42:14.752091Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:42:14.7522Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:42:14.752226Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:42:14.753404Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T11:42:14.758353Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-15T11:42:16.439768Z","caller":"traceutil/trace.go:171","msg":"trace[416545964] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"294.541131ms","start":"2026-06-15T11:42:16.145182Z","end":"2026-06-15T11:42:16.439723Z","steps":["trace[416545964] 'process raft request' (duration: 294.345949ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.439895Z","caller":"traceutil/trace.go:171","msg":"trace[1190323670] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"284.020667ms","start":"2026-06-15T11:42:16.155843Z","end":"2026-06-15T11:42:16.439864Z","steps":["trace[1190323670] 'read index received' (duration: 49.04417ms)","trace[1190323670] 'applied index is now lower than readState.Index' (duration: 234.975157ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:42:16.439945Z","caller":"traceutil/trace.go:171","msg":"trace[1830230509] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"242.355619ms","start":"2026-06-15T11:42:16.197559Z","end":"2026-06-15T11:42:16.439915Z","steps":["trace[1830230509] 'process raft request' (duration: 242.227187ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.440202Z","caller":"traceutil/trace.go:171","msg":"trace[1685842945] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"241.122957ms","start":"2026-06-15T11:42:16.199018Z","end":"2026-06-15T11:42:16.440141Z","steps":["trace[1685842945] 'process raft request' (duration: 240.809814ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.440314Z","caller":"traceutil/trace.go:171","msg":"trace[450887770] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"242.791243ms","start":"2026-06-15T11:42:16.197509Z","end":"2026-06-15T11:42:16.4403Z","steps":["trace[450887770] 'process raft request' (duration: 242.231528ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.44029Z","caller":"traceutil/trace.go:171","msg":"trace[1646648262] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"242.825504ms","start":"2026-06-15T11:42:16.197409Z","end":"2026-06-15T11:42:16.440235Z","steps":["trace[1646648262] 'process raft request' (duration: 242.259208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.440365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.459381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.439994Z","caller":"traceutil/trace.go:171","msg":"trace[242567957] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"242.391039ms","start":"2026-06-15T11:42:16.197473Z","end":"2026-06-15T11:42:16.439864Z","steps":["trace[242567957] 'process raft request' (duration: 242.233067ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.440454Z","caller":"traceutil/trace.go:171","msg":"trace[1950632459] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"284.621513ms","start":"2026-06-15T11:42:16.15582Z","end":"2026-06-15T11:42:16.440442Z","steps":["trace[1950632459] 'agreement among raft nodes before linearized reading' (duration: 284.413411ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.440483Z","caller":"traceutil/trace.go:171","msg":"trace[102925654] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"242.916284ms","start":"2026-06-15T11:42:16.197548Z","end":"2026-06-15T11:42:16.440464Z","steps":["trace[102925654] 'process raft request' (duration: 242.219407ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.470447Z","caller":"traceutil/trace.go:171","msg":"trace[782239608] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"238.32462ms","start":"2026-06-15T11:42:16.232094Z","end":"2026-06-15T11:42:16.470419Z","steps":["trace[782239608] 'process raft request' (duration: 238.28275ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.470534Z","caller":"traceutil/trace.go:171","msg":"trace[1809451714] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"259.570498ms","start":"2026-06-15T11:42:16.210877Z","end":"2026-06-15T11:42:16.470447Z","steps":["trace[1809451714] 'process raft request' (duration: 259.367566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.47087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.340273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-15T11:42:16.470893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.547315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.470943Z","caller":"traceutil/trace.go:171","msg":"trace[308639760] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"221.477214ms","start":"2026-06-15T11:42:16.249444Z","end":"2026-06-15T11:42:16.470921Z","steps":["trace[308639760] 'agreement among raft nodes before linearized reading' (duration: 221.209221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.47092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.614315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.470957Z","caller":"traceutil/trace.go:171","msg":"trace[959331054] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"272.636516ms","start":"2026-06-15T11:42:16.198305Z","end":"2026-06-15T11:42:16.470942Z","steps":["trace[959331054] 'agreement among raft nodes before linearized reading' (duration: 272.503725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.471027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.626755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.471046Z","caller":"traceutil/trace.go:171","msg":"trace[1432575322] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"273.788028ms","start":"2026-06-15T11:42:16.197229Z","end":"2026-06-15T11:42:16.471017Z","steps":["trace[1432575322] 'agreement among raft nodes before linearized reading' (duration: 273.408004ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.471069Z","caller":"traceutil/trace.go:171","msg":"trace[177612830] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:0; response_revision:11; }","duration":"278.679455ms","start":"2026-06-15T11:42:16.192377Z","end":"2026-06-15T11:42:16.471056Z","steps":["trace[177612830] 'agreement among raft nodes before linearized reading' (duration: 278.629405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.471044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.548634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.471205Z","caller":"traceutil/trace.go:171","msg":"trace[216600851] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"280.828306ms","start":"2026-06-15T11:42:16.190345Z","end":"2026-06-15T11:42:16.471174Z","steps":["trace[216600851] 'agreement among raft nodes before linearized reading' (duration: 280.500683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:16.470968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.731635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-15T11:42:16.471024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.637456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-15T11:42:16.471332Z","caller":"traceutil/trace.go:171","msg":"trace[813072900] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"282.14095ms","start":"2026-06-15T11:42:16.189178Z","end":"2026-06-15T11:42:16.471319Z","steps":["trace[813072900] 'agreement among raft nodes before linearized reading' (duration: 281.710966ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:16.471355Z","caller":"traceutil/trace.go:171","msg":"trace[1100538699] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"274.06512ms","start":"2026-06-15T11:42:16.197268Z","end":"2026-06-15T11:42:16.471333Z","steps":["trace[1100538699] 'agreement among raft nodes before linearized reading' (duration: 273.340653ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.983977Z","caller":"traceutil/trace.go:171","msg":"trace[1876591219] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"161.111943ms","start":"2026-06-15T11:42:51.822814Z","end":"2026-06-15T11:42:51.983926Z","steps":["trace[1876591219] 'process raft request' (duration: 160.281067ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.98401Z","caller":"traceutil/trace.go:171","msg":"trace[1486776797] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"152.630097ms","start":"2026-06-15T11:42:51.831346Z","end":"2026-06-15T11:42:51.983976Z","steps":["trace[1486776797] 'process raft request' (duration: 152.534746ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.984199Z","caller":"traceutil/trace.go:171","msg":"trace[562014181] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"133.371239ms","start":"2026-06-15T11:42:51.850817Z","end":"2026-06-15T11:42:51.984189Z","steps":["trace[562014181] 'process raft request' (duration: 133.174808ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.984152Z","caller":"traceutil/trace.go:171","msg":"trace[1353472578] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"142.639631ms","start":"2026-06-15T11:42:51.841433Z","end":"2026-06-15T11:42:51.984073Z","steps":["trace[1353472578] 'process raft request' (duration: 142.49487ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.984193Z","caller":"traceutil/trace.go:171","msg":"trace[466286916] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"137.229765ms","start":"2026-06-15T11:42:51.846886Z","end":"2026-06-15T11:42:51.984115Z","steps":["trace[466286916] 'process raft request' (duration: 137.075234ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.984748Z","caller":"traceutil/trace.go:171","msg":"trace[1870669524] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"130.33691ms","start":"2026-06-15T11:42:51.853878Z","end":"2026-06-15T11:42:51.984215Z","steps":["trace[1870669524] 'process raft request' (duration: 130.143498ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.990761Z","caller":"traceutil/trace.go:171","msg":"trace[1871570851] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"122.86074ms","start":"2026-06-15T11:42:51.867881Z","end":"2026-06-15T11:42:51.990742Z","steps":["trace[1871570851] 'process raft request' (duration: 122.253486ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.990818Z","caller":"traceutil/trace.go:171","msg":"trace[38003586] transaction","detail":"{read_only:false; number_of_response:1; response_revision:534; }","duration":"122.326107ms","start":"2026-06-15T11:42:51.868473Z","end":"2026-06-15T11:42:51.9908Z","steps":["trace[38003586] 'process raft request' (duration: 121.838664ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.990974Z","caller":"traceutil/trace.go:171","msg":"trace[300921088] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"123.050591ms","start":"2026-06-15T11:42:51.867912Z","end":"2026-06-15T11:42:51.990963Z","steps":["trace[300921088] 'process raft request' (duration: 122.344147ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.991105Z","caller":"traceutil/trace.go:171","msg":"trace[366736582] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"120.920327ms","start":"2026-06-15T11:42:51.870174Z","end":"2026-06-15T11:42:51.991095Z","steps":["trace[366736582] 'process raft request' (duration: 120.177072ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.991124Z","caller":"traceutil/trace.go:171","msg":"trace[458514806] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"116.565528ms","start":"2026-06-15T11:42:51.874537Z","end":"2026-06-15T11:42:51.991102Z","steps":["trace[458514806] 'process raft request' (duration: 115.868914ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:51.991209Z","caller":"traceutil/trace.go:171","msg":"trace[1873358460] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"107.109827ms","start":"2026-06-15T11:42:51.884084Z","end":"2026-06-15T11:42:51.991194Z","steps":["trace[1873358460] 'process raft request' (duration: 106.372662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:57.40727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.239524ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:42:57.407421Z","caller":"traceutil/trace.go:171","msg":"trace[1112246151] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"355.265038ms","start":"2026-06-15T11:42:57.052134Z","end":"2026-06-15T11:42:57.407399Z","steps":["trace[1112246151] 'process raft request' (duration: 197.155738ms)","trace[1112246151] 'compare' (duration: 157.078243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:42:57.407507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:42:57.052116Z","time spent":"355.34845ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:42:58.131546Z","caller":"traceutil/trace.go:171","msg":"trace[1879618746] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"147.706828ms","start":"2026-06-15T11:42:57.983815Z","end":"2026-06-15T11:42:58.131522Z","steps":["trace[1879618746] 'read index received' (duration: 147.037424ms)","trace[1879618746] 'applied index is now lower than readState.Index' (duration: 668.404µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:42:58.13159Z","caller":"traceutil/trace.go:171","msg":"trace[702486921] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"194.510245ms","start":"2026-06-15T11:42:57.937066Z","end":"2026-06-15T11:42:58.131576Z","steps":["trace[702486921] 'process raft request' (duration: 193.943711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:58.131715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.88479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T11:42:58.132206Z","caller":"traceutil/trace.go:171","msg":"trace[655108840] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:621; }","duration":"148.033891ms","start":"2026-06-15T11:42:57.983771Z","end":"2026-06-15T11:42:58.131805Z","steps":["trace[655108840] 'agreement among raft nodes before linearized reading' (duration: 147.89225ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:58.906134Z","caller":"traceutil/trace.go:171","msg":"trace[1428523364] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"754.098463ms","start":"2026-06-15T11:42:58.15201Z","end":"2026-06-15T11:42:58.906109Z","steps":["trace[1428523364] 'process raft request' (duration: 754.038762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:58.906264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:42:58.151989Z","time spent":"754.212693ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:42:58.906376Z","caller":"traceutil/trace.go:171","msg":"trace[1167883763] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"770.585566ms","start":"2026-06-15T11:42:58.135762Z","end":"2026-06-15T11:42:58.906348Z","steps":["trace[1167883763] 'process raft request' (duration: 739.40858ms)","trace[1167883763] 'compare' (duration: 30.760503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:42:58.906556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:42:58.135751Z","time spent":"770.700767ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:42:58.926373Z","caller":"traceutil/trace.go:171","msg":"trace[197405754] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"735.224974ms","start":"2026-06-15T11:42:58.191118Z","end":"2026-06-15T11:42:58.926343Z","steps":["trace[197405754] 'process raft request' (duration: 734.990522ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:42:58.926368Z","caller":"traceutil/trace.go:171","msg":"trace[1700232662] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:643; }","duration":"273.270459ms","start":"2026-06-15T11:42:58.653079Z","end":"2026-06-15T11:42:58.92635Z","steps":["trace[1700232662] 'read index received' (duration: 222.101307ms)","trace[1700232662] 'applied index is now lower than readState.Index' (duration: 51.168002ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:42:58.926434Z","caller":"traceutil/trace.go:171","msg":"trace[2002172998] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"734.805151ms","start":"2026-06-15T11:42:58.191595Z","end":"2026-06-15T11:42:58.9264Z","steps":["trace[2002172998] 'process raft request' (duration: 734.62153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:58.927244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:42:58.191576Z","time spent":"735.588046ms","remote":"127.0.0.1:36012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:42:58.92655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:42:58.927408Z","caller":"traceutil/trace.go:171","msg":"trace[2085763714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"274.341725ms","start":"2026-06-15T11:42:58.653045Z","end":"2026-06-15T11:42:58.927386Z","steps":["trace[2085763714] 'agreement among raft nodes before linearized reading' (duration: 273.368879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:58.927413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.071405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T11:42:58.927472Z","caller":"traceutil/trace.go:171","msg":"trace[36903940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"166.164215ms","start":"2026-06-15T11:42:58.761288Z","end":"2026-06-15T11:42:58.927453Z","steps":["trace[36903940] 'agreement among raft nodes before linearized reading' (duration: 165.992264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:42:58.927121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:42:58.191098Z","time spent":"735.899508ms","remote":"127.0.0.1:36204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T11:43:11.382102Z","caller":"traceutil/trace.go:171","msg":"trace[1179049195] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"189.346569ms","start":"2026-06-15T11:43:11.192729Z","end":"2026-06-15T11:43:11.382075Z","steps":["trace[1179049195] 'process raft request' (duration: 188.246813ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:43:14.427435Z","caller":"traceutil/trace.go:171","msg":"trace[1838841439] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"269.892651ms","start":"2026-06-15T11:43:14.157501Z","end":"2026-06-15T11:43:14.427393Z","steps":["trace[1838841439] 'process raft request' (duration: 268.00812ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:43:42.975763Z","caller":"traceutil/trace.go:171","msg":"trace[1673219736] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"111.878802ms","start":"2026-06-15T11:43:42.863856Z","end":"2026-06-15T11:43:42.975734Z","steps":["trace[1673219736] 'process raft request' (duration: 111.716456ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:31.84964Z","caller":"traceutil/trace.go:171","msg":"trace[1671679200] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"277.257899ms","start":"2026-06-15T11:44:31.572354Z","end":"2026-06-15T11:44:31.849612Z","steps":["trace[1671679200] 'read index received' (duration: 277.088305ms)","trace[1671679200] 'applied index is now lower than readState.Index' (duration: 168.404µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:44:31.849882Z","caller":"traceutil/trace.go:171","msg":"trace[149519695] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"303.477719ms","start":"2026-06-15T11:44:31.546344Z","end":"2026-06-15T11:44:31.849822Z","steps":["trace[149519695] 'process raft request' (duration: 303.10436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:31.84991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.534835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b2167cc7-a7e9-4518-9440-b55f29a7859b\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-15T11:44:31.850292Z","caller":"traceutil/trace.go:171","msg":"trace[1766598435] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b2167cc7-a7e9-4518-9440-b55f29a7859b; range_end:; response_count:1; response_revision:1879; }","duration":"277.945244ms","start":"2026-06-15T11:44:31.572324Z","end":"2026-06-15T11:44:31.850269Z","steps":["trace[1766598435] 'agreement among raft nodes before linearized reading' (duration: 277.517584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:31.850176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:44:31.546328Z","time spent":"303.663854ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:44:32.123132Z","caller":"traceutil/trace.go:171","msg":"trace[837843524] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"273.14867ms","start":"2026-06-15T11:44:31.849968Z","end":"2026-06-15T11:44:32.123116Z","steps":["trace[837843524] 'read index received' (duration: 190.71696ms)","trace[837843524] 'applied index is now lower than readState.Index' (duration: 82.43107ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:44:32.123312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.39355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:44:32.123401Z","caller":"traceutil/trace.go:171","msg":"trace[1881407493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1881; }","duration":"471.516093ms","start":"2026-06-15T11:44:31.651874Z","end":"2026-06-15T11:44:32.12339Z","steps":["trace[1881407493] 'agreement among raft nodes before linearized reading' (duration: 471.373009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:32.12348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:44:31.651862Z","time spent":"471.607504ms","remote":"127.0.0.1:35968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T11:44:32.123564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.546079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-15T11:44:32.12355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.511779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T11:44:32.123598Z","caller":"traceutil/trace.go:171","msg":"trace[1472258265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1881; }","duration":"235.622241ms","start":"2026-06-15T11:44:31.887968Z","end":"2026-06-15T11:44:32.12359Z","steps":["trace[1472258265] 'agreement among raft nodes before linearized reading' (duration: 235.527639ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.123626Z","caller":"traceutil/trace.go:171","msg":"trace[2002209604] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1881; }","duration":"149.652313ms","start":"2026-06-15T11:44:31.973957Z","end":"2026-06-15T11:44:32.12361Z","steps":["trace[2002209604] 'agreement among raft nodes before linearized reading' (duration: 149.502779ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.123151Z","caller":"traceutil/trace.go:171","msg":"trace[398683339] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"357.234035ms","start":"2026-06-15T11:44:31.765882Z","end":"2026-06-15T11:44:32.123116Z","steps":["trace[398683339] 'process raft request' (duration: 274.801124ms)","trace[398683339] 'compare' (duration: 82.312529ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:44:32.123705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.842511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"warn","ts":"2026-06-15T11:44:32.123831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:44:31.765853Z","time spent":"357.886261ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:44:32.123934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.009935ms","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-06-15T11:44:32.124019Z","caller":"traceutil/trace.go:171","msg":"trace[841179088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"269.117098ms","start":"2026-06-15T11:44:31.85486Z","end":"2026-06-15T11:44:32.123977Z","steps":["trace[841179088] 'agreement among raft nodes before linearized reading' (duration: 268.866842ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.123855Z","caller":"traceutil/trace.go:171","msg":"trace[704119746] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1881; }","duration":"269.082357ms","start":"2026-06-15T11:44:31.854763Z","end":"2026-06-15T11:44:32.123845Z","steps":["trace[704119746] 'agreement among raft nodes before linearized reading' (duration: 268.624127ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.293611Z","caller":"traceutil/trace.go:171","msg":"trace[2026791419] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"153.991504ms","start":"2026-06-15T11:44:32.13959Z","end":"2026-06-15T11:44:32.293581Z","steps":["trace[2026791419] 'process raft request' (duration: 146.872063ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.296949Z","caller":"traceutil/trace.go:171","msg":"trace[1367212973] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"115.865369ms","start":"2026-06-15T11:44:32.181051Z","end":"2026-06-15T11:44:32.296916Z","steps":["trace[1367212973] 'process raft request' (duration: 115.729456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:32.573083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.444434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:44:32.57325Z","caller":"traceutil/trace.go:171","msg":"trace[536299616] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"272.090597ms","start":"2026-06-15T11:44:32.30109Z","end":"2026-06-15T11:44:32.57318Z","steps":["trace[536299616] 'process raft request' (duration: 140.451629ms)","trace[536299616] 'compare' (duration: 131.163257ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:44:32.599203Z","caller":"traceutil/trace.go:171","msg":"trace[1350581650] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"297.932503ms","start":"2026-06-15T11:44:32.301246Z","end":"2026-06-15T11:44:32.599179Z","steps":["trace[1350581650] 'process raft request' (duration: 297.630386ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.599543Z","caller":"traceutil/trace.go:171","msg":"trace[761106489] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"297.900832ms","start":"2026-06-15T11:44:32.301608Z","end":"2026-06-15T11:44:32.599509Z","steps":["trace[761106489] 'process raft request' (duration: 297.666597ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:32.599352Z","caller":"traceutil/trace.go:171","msg":"trace[23711547] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"298.040705ms","start":"2026-06-15T11:44:32.301289Z","end":"2026-06-15T11:44:32.59933Z","steps":["trace[23711547] 'process raft request' (duration: 297.720978ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:45.051474Z","caller":"traceutil/trace.go:171","msg":"trace[184297350] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"114.221088ms","start":"2026-06-15T11:44:44.937228Z","end":"2026-06-15T11:44:45.051449Z","steps":["trace[184297350] 'process raft request' (duration: 114.054264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:47.814046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.05545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:44:47.814108Z","caller":"traceutil/trace.go:171","msg":"trace[1507552393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2010; }","duration":"162.150462ms","start":"2026-06-15T11:44:47.651943Z","end":"2026-06-15T11:44:47.814094Z","steps":["trace[1507552393] 'range keys from in-memory index tree' (duration: 161.987499ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:48.375406Z","caller":"traceutil/trace.go:171","msg":"trace[108513614] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"178.087534ms","start":"2026-06-15T11:44:48.197295Z","end":"2026-06-15T11:44:48.375383Z","steps":["trace[108513614] 'process raft request' (duration: 177.983892ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:48.375406Z","caller":"traceutil/trace.go:171","msg":"trace[1657246662] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"188.537522ms","start":"2026-06-15T11:44:48.186841Z","end":"2026-06-15T11:44:48.375378Z","steps":["trace[1657246662] 'process raft request' (duration: 186.376219ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:44:48.375514Z","caller":"traceutil/trace.go:171","msg":"trace[343094623] linearizableReadLoop","detail":"{readStateIndex:2094; appliedIndex:2092; }","duration":"168.341621ms","start":"2026-06-15T11:44:48.207158Z","end":"2026-06-15T11:44:48.3755Z","steps":["trace[343094623] 'read index received' (duration: 166.041545ms)","trace[343094623] 'applied index is now lower than readState.Index' (duration: 2.298346ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:44:48.376309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.310061ms","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-06-15T11:44:48.376364Z","caller":"traceutil/trace.go:171","msg":"trace[1306604577] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2021; }","duration":"145.395404ms","start":"2026-06-15T11:44:48.230955Z","end":"2026-06-15T11:44:48.376351Z","steps":["trace[1306604577] 'agreement among raft nodes before linearized reading' (duration: 145.250061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:48.376763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.593695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T11:44:48.376823Z","caller":"traceutil/trace.go:171","msg":"trace[439591200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2021; }","duration":"169.677437ms","start":"2026-06-15T11:44:48.207133Z","end":"2026-06-15T11:44:48.37681Z","steps":["trace[439591200] 'agreement among raft nodes before linearized reading' (duration: 168.622456ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:11.8287Z","caller":"traceutil/trace.go:171","msg":"trace[1161523981] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"141.227672ms","start":"2026-06-15T11:45:11.687449Z","end":"2026-06-15T11:45:11.828676Z","steps":["trace[1161523981] 'process raft request' (duration: 141.09849ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:11.83744Z","caller":"traceutil/trace.go:171","msg":"trace[604551953] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"149.877969ms","start":"2026-06-15T11:45:11.687548Z","end":"2026-06-15T11:45:11.837426Z","steps":["trace[604551953] 'process raft request' (duration: 149.596384ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:11.837501Z","caller":"traceutil/trace.go:171","msg":"trace[1120529472] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"149.817178ms","start":"2026-06-15T11:45:11.68766Z","end":"2026-06-15T11:45:11.837477Z","steps":["trace[1120529472] 'process raft request' (duration: 149.600064ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:12.579841Z","caller":"traceutil/trace.go:171","msg":"trace[1960854382] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"123.322306ms","start":"2026-06-15T11:45:12.456498Z","end":"2026-06-15T11:45:12.579821Z","steps":["trace[1960854382] 'process raft request' (duration: 123.174253ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:12.802726Z","caller":"traceutil/trace.go:171","msg":"trace[1453965869] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2231; }","duration":"337.418768ms","start":"2026-06-15T11:45:12.465272Z","end":"2026-06-15T11:45:12.80269Z","steps":["trace[1453965869] 'read index received' (duration: 114.439326ms)","trace[1453965869] 'applied index is now lower than readState.Index' (duration: 222.978142ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:45:12.802878Z","caller":"traceutil/trace.go:171","msg":"trace[1490811624] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"345.339281ms","start":"2026-06-15T11:45:12.45752Z","end":"2026-06-15T11:45:12.80286Z","steps":["trace[1490811624] 'process raft request' (duration: 345.000565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:12.803083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:45:12.45749Z","time spent":"345.475194ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:45:12.803303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.049068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:45:12.803321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.836032ms","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-06-15T11:45:12.803408Z","caller":"traceutil/trace.go:171","msg":"trace[874363713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"149.194551ms","start":"2026-06-15T11:45:12.654165Z","end":"2026-06-15T11:45:12.80336Z","steps":["trace[874363713] 'agreement among raft nodes before linearized reading' (duration: 149.052538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:12.803349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.047679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T11:45:12.803453Z","caller":"traceutil/trace.go:171","msg":"trace[513471319] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"345.29178ms","start":"2026-06-15T11:45:12.458066Z","end":"2026-06-15T11:45:12.803358Z","steps":["trace[513471319] 'process raft request' (duration: 344.582849ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:12.803479Z","caller":"traceutil/trace.go:171","msg":"trace[549418617] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2156; }","duration":"269.943673ms","start":"2026-06-15T11:45:12.533425Z","end":"2026-06-15T11:45:12.803369Z","steps":["trace[549418617] 'agreement among raft nodes before linearized reading' (duration: 269.665368ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:12.80353Z","caller":"traceutil/trace.go:171","msg":"trace[1148180805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2156; }","duration":"338.242612ms","start":"2026-06-15T11:45:12.465265Z","end":"2026-06-15T11:45:12.803508Z","steps":["trace[1148180805] 'agreement among raft nodes before linearized reading' (duration: 337.703603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:12.803674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:45:12.465227Z","time spent":"338.433326ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T11:45:12.803739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:45:12.458055Z","time spent":"345.528494ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:46:10.927647Z","caller":"traceutil/trace.go:171","msg":"trace[562033680] transaction","detail":"{read_only:false; response_revision:2573; number_of_response:1; }","duration":"168.866005ms","start":"2026-06-15T11:46:10.758748Z","end":"2026-06-15T11:46:10.927615Z","steps":["trace[562033680] 'process raft request' (duration: 168.645222ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:46:43.360671Z","caller":"traceutil/trace.go:171","msg":"trace[1256629969] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"121.124951ms","start":"2026-06-15T11:46:43.239525Z","end":"2026-06-15T11:46:43.36065Z","steps":["trace[1256629969] 'process raft request' (duration: 118.058835ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.378889Z","caller":"traceutil/trace.go:171","msg":"trace[1389530733] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"143.319043ms","start":"2026-06-15T11:50:29.235539Z","end":"2026-06-15T11:50:29.378858Z","steps":["trace[1389530733] 'process raft request' (duration: 143.104189ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.604706Z","caller":"traceutil/trace.go:171","msg":"trace[637786530] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"101.336063ms","start":"2026-06-15T11:50:29.503321Z","end":"2026-06-15T11:50:29.604657Z","steps":["trace[637786530] 'process raft request' (duration: 70.204824ms)","trace[637786530] 'compare' (duration: 30.823503ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:50:29.60473Z","caller":"traceutil/trace.go:171","msg":"trace[695980264] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"100.935065ms","start":"2026-06-15T11:50:29.503758Z","end":"2026-06-15T11:50:29.604693Z","steps":["trace[695980264] 'process raft request' (duration: 100.729651ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.605063Z","caller":"traceutil/trace.go:171","msg":"trace[1878933478] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"101.18404ms","start":"2026-06-15T11:50:29.503863Z","end":"2026-06-15T11:50:29.605047Z","steps":["trace[1878933478] 'process raft request' (duration: 100.67968ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.605131Z","caller":"traceutil/trace.go:171","msg":"trace[1748814679] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"100.200501ms","start":"2026-06-15T11:50:29.504902Z","end":"2026-06-15T11:50:29.605102Z","steps":["trace[1748814679] 'process raft request' (duration: 99.715981ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.888982Z","caller":"traceutil/trace.go:171","msg":"trace[103517242] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"102.098617ms","start":"2026-06-15T11:50:29.786853Z","end":"2026-06-15T11:50:29.888952Z","steps":["trace[103517242] 'process raft request' (duration: 50.239213ms)","trace[103517242] 'compare' (duration: 51.63078ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:50:29.889335Z","caller":"traceutil/trace.go:171","msg":"trace[347180107] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"101.981315ms","start":"2026-06-15T11:50:29.787339Z","end":"2026-06-15T11:50:29.889321Z","steps":["trace[347180107] 'process raft request' (duration: 101.554517ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.889473Z","caller":"traceutil/trace.go:171","msg":"trace[1251650868] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"101.077737ms","start":"2026-06-15T11:50:29.788381Z","end":"2026-06-15T11:50:29.889458Z","steps":["trace[1251650868] 'process raft request' (duration: 100.600758ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:29.889532Z","caller":"traceutil/trace.go:171","msg":"trace[371155663] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"101.163329ms","start":"2026-06-15T11:50:29.788336Z","end":"2026-06-15T11:50:29.889499Z","steps":["trace[371155663] 'process raft request' (duration: 100.605358ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:30.040357Z","caller":"traceutil/trace.go:171","msg":"trace[455070769] linearizableReadLoop","detail":"{readStateIndex:4857; appliedIndex:4855; }","duration":"103.321799ms","start":"2026-06-15T11:50:29.937008Z","end":"2026-06-15T11:50:30.04033Z","steps":["trace[455070769] 'read index received' (duration: 85.632394ms)","trace[455070769] 'applied index is now lower than readState.Index' (duration: 17.688045ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:50:30.04067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.635286ms","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-06-15T11:50:30.040713Z","caller":"traceutil/trace.go:171","msg":"trace[8286348] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4682; }","duration":"103.721467ms","start":"2026-06-15T11:50:29.936981Z","end":"2026-06-15T11:50:30.040702Z","steps":["trace[8286348] 'agreement among raft nodes before linearized reading' (duration: 103.445442ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:30.041107Z","caller":"traceutil/trace.go:171","msg":"trace[1025774184] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"108.572072ms","start":"2026-06-15T11:50:29.932521Z","end":"2026-06-15T11:50:30.041093Z","steps":["trace[1025774184] 'process raft request' (duration: 90.104932ms)","trace[1025774184] 'compare' (duration: 16.95087ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:50:30.041547Z","caller":"traceutil/trace.go:171","msg":"trace[1882975027] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"107.695615ms","start":"2026-06-15T11:50:29.933839Z","end":"2026-06-15T11:50:30.041535Z","steps":["trace[1882975027] 'process raft request' (duration: 106.39821ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:32.464412Z","caller":"traceutil/trace.go:171","msg":"trace[1095498769] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"113.178788ms","start":"2026-06-15T11:50:32.351209Z","end":"2026-06-15T11:50:32.464388Z","steps":["trace[1095498769] 'process raft request' (duration: 113.051135ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.628663Z","caller":"traceutil/trace.go:171","msg":"trace[637064328] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5065; }","duration":"135.609281ms","start":"2026-06-15T11:50:42.493029Z","end":"2026-06-15T11:50:42.628638Z","steps":["trace[637064328] 'read index received' (duration: 135.511639ms)","trace[637064328] 'applied index is now lower than readState.Index' (duration: 96.362µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:50:42.628983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.940427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-15T11:50:42.629066Z","caller":"traceutil/trace.go:171","msg":"trace[503932738] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4886; }","duration":"136.0742ms","start":"2026-06-15T11:50:42.492976Z","end":"2026-06-15T11:50:42.62905Z","steps":["trace[503932738] 'agreement among raft nodes before linearized reading' (duration: 135.767074ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.62904Z","caller":"traceutil/trace.go:171","msg":"trace[83316077] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"141.567954ms","start":"2026-06-15T11:50:42.487443Z","end":"2026-06-15T11:50:42.629011Z","steps":["trace[83316077] 'process raft request' (duration: 140.997933ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.875381Z","caller":"traceutil/trace.go:171","msg":"trace[1882344485] linearizableReadLoop","detail":"{readStateIndex:5067; appliedIndex:5066; }","duration":"240.905276ms","start":"2026-06-15T11:50:42.634455Z","end":"2026-06-15T11:50:42.87536Z","steps":["trace[1882344485] 'read index received' (duration: 219.939369ms)","trace[1882344485] 'applied index is now lower than readState.Index' (duration: 20.964887ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:50:42.875501Z","caller":"traceutil/trace.go:171","msg":"trace[308514823] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"378.581997ms","start":"2026-06-15T11:50:42.496902Z","end":"2026-06-15T11:50:42.875484Z","steps":["trace[308514823] 'process raft request' (duration: 357.409615ms)","trace[308514823] 'compare' (duration: 20.668152ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:50:42.875623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:50:42.496878Z","time spent":"378.656768ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:50:42.875783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.317334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-91819b2b-15f9-4551-bf71-0257403be480\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-15T11:50:42.87584Z","caller":"traceutil/trace.go:171","msg":"trace[1697866169] range","detail":"{range_begin:/registry/persistentvolumes/pvc-91819b2b-15f9-4551-bf71-0257403be480; range_end:; response_count:1; response_revision:4887; }","duration":"241.427006ms","start":"2026-06-15T11:50:42.634398Z","end":"2026-06-15T11:50:42.875825Z","steps":["trace[1697866169] 'agreement among raft nodes before linearized reading' (duration: 241.13475ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.935299Z","caller":"traceutil/trace.go:171","msg":"trace[1300037133] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"300.292992ms","start":"2026-06-15T11:50:42.634981Z","end":"2026-06-15T11:50:42.935274Z","steps":["trace[1300037133] 'process raft request' (duration: 300.070838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:50:42.935478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:50:42.634957Z","time spent":"300.425454ms","remote":"127.0.0.1:36270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:50:42.935642Z","caller":"traceutil/trace.go:171","msg":"trace[544045638] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"291.79531ms","start":"2026-06-15T11:50:42.643821Z","end":"2026-06-15T11:50:42.935617Z","steps":["trace[544045638] 'process raft request' (duration: 291.394703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:50:42.935804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.735536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:50:42.935884Z","caller":"traceutil/trace.go:171","msg":"trace[581298641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4891; }","duration":"285.852208ms","start":"2026-06-15T11:50:42.650015Z","end":"2026-06-15T11:50:42.935867Z","steps":["trace[581298641] 'agreement among raft nodes before linearized reading' (duration: 285.654174ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.935996Z","caller":"traceutil/trace.go:171","msg":"trace[794921720] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"291.971184ms","start":"2026-06-15T11:50:42.644016Z","end":"2026-06-15T11:50:42.935987Z","steps":["trace[794921720] 'process raft request' (duration: 291.582937ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:42.936073Z","caller":"traceutil/trace.go:171","msg":"trace[379463352] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"292.126537ms","start":"2026-06-15T11:50:42.643938Z","end":"2026-06-15T11:50:42.936065Z","steps":["trace[379463352] 'process raft request' (duration: 291.545416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:50:42.936209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.95919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T11:50:42.936247Z","caller":"traceutil/trace.go:171","msg":"trace[1070907620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4891; }","duration":"256.997781ms","start":"2026-06-15T11:50:42.67924Z","end":"2026-06-15T11:50:42.936237Z","steps":["trace[1070907620] 'agreement among raft nodes before linearized reading' (duration: 256.881119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.528234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.028941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T11:51:33.528391Z","caller":"traceutil/trace.go:171","msg":"trace[1520271050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5318; }","duration":"243.228794ms","start":"2026-06-15T11:51:33.285136Z","end":"2026-06-15T11:51:33.528365Z","steps":["trace[1520271050] 'range keys from in-memory index tree' (duration: 242.795087ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:33.529234Z","caller":"traceutil/trace.go:171","msg":"trace[1835179282] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"154.461908ms","start":"2026-06-15T11:51:33.373925Z","end":"2026-06-15T11:51:33.528387Z","steps":["trace[1835179282] 'process raft request' (duration: 95.603743ms)","trace[1835179282] 'compare' (duration: 58.700893ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:33.633784Z","caller":"traceutil/trace.go:171","msg":"trace[429386350] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"101.436413ms","start":"2026-06-15T11:51:33.532312Z","end":"2026-06-15T11:51:33.633748Z","steps":["trace[429386350] 'process raft request' (duration: 101.28757ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:33.966442Z","caller":"traceutil/trace.go:171","msg":"trace[502505122] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"136.130395ms","start":"2026-06-15T11:51:33.830284Z","end":"2026-06-15T11:51:33.966415Z","steps":["trace[502505122] 'process raft request' (duration: 135.980662ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:34.180084Z","caller":"traceutil/trace.go:171","msg":"trace[1470684485] linearizableReadLoop","detail":"{readStateIndex:5515; appliedIndex:5513; }","duration":"335.311112ms","start":"2026-06-15T11:51:33.844749Z","end":"2026-06-15T11:51:34.18006Z","steps":["trace[1470684485] 'read index received' (duration: 121.476015ms)","trace[1470684485] 'applied index is now lower than readState.Index' (duration: 213.831127ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:34.180208Z","caller":"traceutil/trace.go:171","msg":"trace[1880988020] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"347.896457ms","start":"2026-06-15T11:51:33.832268Z","end":"2026-06-15T11:51:34.180165Z","steps":["trace[1880988020] 'process raft request' (duration: 347.611942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:34.180495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.728279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T11:51:34.180921Z","caller":"traceutil/trace.go:171","msg":"trace[945081211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5322; }","duration":"336.204107ms","start":"2026-06-15T11:51:33.844694Z","end":"2026-06-15T11:51:34.180898Z","steps":["trace[945081211] 'agreement among raft nodes before linearized reading' (duration: 335.588657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:34.181052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.844674Z","time spent":"336.358409ms","remote":"127.0.0.1:36268","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":"warn","ts":"2026-06-15T11:51:34.180973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.832246Z","time spent":"348.442907ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7196,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:51:34.181101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.643497ms","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-06-15T11:51:34.181411Z","caller":"traceutil/trace.go:171","msg":"trace[2142569549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5322; }","duration":"229.993053ms","start":"2026-06-15T11:51:33.9514Z","end":"2026-06-15T11:51:34.181393Z","steps":["trace[2142569549] 'agreement among raft nodes before linearized reading' (duration: 229.468634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:34.181717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.615405ms","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-06-15T11:51:34.181828Z","caller":"traceutil/trace.go:171","msg":"trace[328243591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5322; }","duration":"329.740677ms","start":"2026-06-15T11:51:33.852044Z","end":"2026-06-15T11:51:34.181785Z","steps":["trace[328243591] 'agreement among raft nodes before linearized reading' (duration: 328.73003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:34.181927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.852031Z","time spent":"329.884639ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T11:51:34.421273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.282257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:51:34.421698Z","caller":"traceutil/trace.go:171","msg":"trace[1539184395] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"233.552762ms","start":"2026-06-15T11:51:34.188118Z","end":"2026-06-15T11:51:34.421671Z","steps":["trace[1539184395] 'process raft request' (duration: 53.769937ms)","trace[1539184395] 'compare' (duration: 179.070363ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:34.421793Z","caller":"traceutil/trace.go:171","msg":"trace[640853318] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"231.840033ms","start":"2026-06-15T11:51:34.189926Z","end":"2026-06-15T11:51:34.421766Z","steps":["trace[640853318] 'process raft request' (duration: 231.548798ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:34.421695Z","caller":"traceutil/trace.go:171","msg":"trace[467282368] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"233.272748ms","start":"2026-06-15T11:51:34.188371Z","end":"2026-06-15T11:51:34.421643Z","steps":["trace[467282368] 'process raft request' (duration: 233.036264ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:14.774881Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-06-15T11:52:14.891906Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"115.648174ms","hash":2394361017,"current-db-size-bytes":54714368,"current-db-size":"55 MB","current-db-size-in-use-bytes":29687808,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-15T11:52:14.891971Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2394361017,"revision":2918,"compact-revision":-1} {"level":"info","ts":"2026-06-15T11:54:31.245609Z","caller":"traceutil/trace.go:171","msg":"trace[336434945] transaction","detail":"{read_only:false; response_revision:6532; number_of_response:1; }","duration":"135.159681ms","start":"2026-06-15T11:54:31.110424Z","end":"2026-06-15T11:54:31.245584Z","steps":["trace[336434945] 'process raft request' (duration: 135.11769ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:54:31.246007Z","caller":"traceutil/trace.go:171","msg":"trace[1398511532] transaction","detail":"{read_only:false; response_revision:6531; number_of_response:1; }","duration":"179.047745ms","start":"2026-06-15T11:54:31.066908Z","end":"2026-06-15T11:54:31.245955Z","steps":["trace[1398511532] 'process raft request' (duration: 158.076497ms)","trace[1398511532] 'compare' (duration: 20.42278ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:57:14.780745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5642} {"level":"info","ts":"2026-06-15T11:57:14.892848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5642,"took":"110.261135ms","hash":2968173068,"current-db-size-bytes":54714368,"current-db-size":"55 MB","current-db-size-in-use-bytes":18214912,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-15T11:57:14.892901Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2968173068,"revision":5642,"compact-revision":2918}