{"level":"warn","ts":"2026-08-22T10:27:42.199741Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:27:42.19986Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-08-22T10:27:42.199943Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:27:42.199952Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-22T10:27:42.199978Z","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-08-22T10:27:42.200825Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-08-22T10:27:42.200948Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-08-22T10:27:42.204738Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.483675ms"} {"level":"info","ts":"2026-08-22T10:27:42.20969Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-08-22T10:27:42.209803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:27:42.209837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-08-22T10:27:42.209851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:27:42.209862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-08-22T10:27:42.209906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-08-22T10:27:42.218659Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:27:42.220054Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:27:42.221149Z","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-08-22T10:27:42.223049Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:27:42.224063Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:27:42.224162Z","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-08-22T10:27:42.225253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-08-22T10:27:42.225438Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-22T10:27:42.225492Z","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-08-22T10:27:42.225508Z","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-08-22T10:27:42.230002Z","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-08-22T10:27:42.23016Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-22T10:27:42.230207Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:27:42.230232Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:27:42.230223Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-22T10:27:42.41095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:27:42.410995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:27:42.411008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-08-22T10:27:42.411019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:27:42.411025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-22T10:27:42.411033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-08-22T10:27:42.411051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-22T10:27:42.418527Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:27:42.419679Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:27:42.419693Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:27:42.419818Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:27:42.423142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:27:42.423202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-08-22T10:27:42.423473Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:27:42.423509Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:27:42.424834Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:27:42.424912Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:27:42.424941Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:27:44.140862Z","caller":"traceutil/trace.go:171","msg":"trace[1667953428] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"140.167878ms","start":"2026-08-22T10:27:44.000666Z","end":"2026-08-22T10:27:44.140834Z","steps":["trace[1667953428] 'read index received' (duration: 140.035292ms)","trace[1667953428] 'applied index is now lower than readState.Index' (duration: 130.926µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:27:44.141045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.355136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.141271Z","caller":"traceutil/trace.go:171","msg":"trace[144709355] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"140.605377ms","start":"2026-08-22T10:27:44.000649Z","end":"2026-08-22T10:27:44.141254Z","steps":["trace[144709355] 'agreement among raft nodes before linearized reading' (duration: 140.288553ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.140901Z","caller":"traceutil/trace.go:171","msg":"trace[272854060] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"141.666112ms","start":"2026-08-22T10:27:43.999209Z","end":"2026-08-22T10:27:44.140875Z","steps":["trace[272854060] 'process raft request' (duration: 141.40236ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.209624Z","caller":"traceutil/trace.go:171","msg":"trace[1059275086] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"133.138882ms","start":"2026-08-22T10:27:44.076448Z","end":"2026-08-22T10:27:44.209587Z","steps":["trace[1059275086] 'process raft request' (duration: 133.016367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.209843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.746534ms","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-08-22T10:27:44.209933Z","caller":"traceutil/trace.go:171","msg":"trace[1674658080] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"124.257086ms","start":"2026-08-22T10:27:44.085659Z","end":"2026-08-22T10:27:44.209916Z","steps":["trace[1674658080] 'process raft request' (duration: 123.857409ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.209989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.674482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.210022Z","caller":"traceutil/trace.go:171","msg":"trace[1385713484] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"135.721584ms","start":"2026-08-22T10:27:44.074293Z","end":"2026-08-22T10:27:44.210014Z","steps":["trace[1385713484] 'agreement among raft nodes before linearized reading' (duration: 135.677502ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.209448Z","caller":"traceutil/trace.go:171","msg":"trace[210791246] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"133.373922ms","start":"2026-08-22T10:27:44.076051Z","end":"2026-08-22T10:27:44.209425Z","steps":["trace[210791246] 'process raft request' (duration: 133.143512ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.210169Z","caller":"traceutil/trace.go:171","msg":"trace[959250064] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"133.659985ms","start":"2026-08-22T10:27:44.076495Z","end":"2026-08-22T10:27:44.210155Z","steps":["trace[959250064] 'process raft request' (duration: 132.992986ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.209537Z","caller":"traceutil/trace.go:171","msg":"trace[1848341390] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"133.372052ms","start":"2026-08-22T10:27:44.076135Z","end":"2026-08-22T10:27:44.209507Z","steps":["trace[1848341390] 'process raft request' (duration: 133.216445ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.210216Z","caller":"traceutil/trace.go:171","msg":"trace[690299525] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"133.904705ms","start":"2026-08-22T10:27:44.076173Z","end":"2026-08-22T10:27:44.210078Z","steps":["trace[690299525] 'process raft request' (duration: 133.224046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.210567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.422404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.210606Z","caller":"traceutil/trace.go:171","msg":"trace[1445487184] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:0; response_revision:10; }","duration":"136.493538ms","start":"2026-08-22T10:27:44.074104Z","end":"2026-08-22T10:27:44.210598Z","steps":["trace[1445487184] 'agreement among raft nodes before linearized reading' (duration: 136.431595ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.209942Z","caller":"traceutil/trace.go:171","msg":"trace[193040166] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"132.974605ms","start":"2026-08-22T10:27:44.076946Z","end":"2026-08-22T10:27:44.20992Z","steps":["trace[193040166] 'agreement among raft nodes before linearized reading' (duration: 132.754705ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.210566Z","caller":"traceutil/trace.go:171","msg":"trace[258422087] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"134.181967ms","start":"2026-08-22T10:27:44.07633Z","end":"2026-08-22T10:27:44.210512Z","steps":["trace[258422087] 'process raft request' (duration: 133.10267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.211102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.75627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.211174Z","caller":"traceutil/trace.go:171","msg":"trace[1430489316] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"206.850733ms","start":"2026-08-22T10:27:44.004303Z","end":"2026-08-22T10:27:44.211153Z","steps":["trace[1430489316] 'agreement among raft nodes before linearized reading' (duration: 206.727738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.211369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.264921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.211407Z","caller":"traceutil/trace.go:171","msg":"trace[806642673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"201.309993ms","start":"2026-08-22T10:27:44.010088Z","end":"2026-08-22T10:27:44.211398Z","steps":["trace[806642673] 'agreement among raft nodes before linearized reading' (duration: 201.25434ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:27:44.211589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.508352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:27:44.211623Z","caller":"traceutil/trace.go:171","msg":"trace[836998858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"201.559114ms","start":"2026-08-22T10:27:44.010056Z","end":"2026-08-22T10:27:44.211615Z","steps":["trace[836998858] 'agreement among raft nodes before linearized reading' (duration: 201.510882ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:27:44.214503Z","caller":"traceutil/trace.go:171","msg":"trace[1683806851] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"118.339919ms","start":"2026-08-22T10:27:44.092311Z","end":"2026-08-22T10:27:44.210651Z","steps":["trace[1683806851] 'process raft request' (duration: 117.236201ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:18.826039Z","caller":"traceutil/trace.go:171","msg":"trace[1213935170] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"147.375732ms","start":"2026-08-22T10:28:18.678624Z","end":"2026-08-22T10:28:18.826Z","steps":["trace[1213935170] 'process raft request' (duration: 89.229952ms)","trace[1213935170] 'compare' (duration: 58.023363ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:28:18.835044Z","caller":"traceutil/trace.go:171","msg":"trace[1470893499] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"101.603675ms","start":"2026-08-22T10:28:18.733413Z","end":"2026-08-22T10:28:18.835017Z","steps":["trace[1470893499] 'process raft request' (duration: 101.455716ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:18.835236Z","caller":"traceutil/trace.go:171","msg":"trace[1684498608] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"132.751992ms","start":"2026-08-22T10:28:18.702475Z","end":"2026-08-22T10:28:18.835227Z","steps":["trace[1684498608] 'process raft request' (duration: 132.259462ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:18.83509Z","caller":"traceutil/trace.go:171","msg":"trace[1548692912] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"137.031713ms","start":"2026-08-22T10:28:18.698037Z","end":"2026-08-22T10:28:18.835069Z","steps":["trace[1548692912] 'process raft request' (duration: 136.566334ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:18.835353Z","caller":"traceutil/trace.go:171","msg":"trace[14659257] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"127.753478ms","start":"2026-08-22T10:28:18.707565Z","end":"2026-08-22T10:28:18.835319Z","steps":["trace[14659257] 'process raft request' (duration: 127.235666ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:19.864855Z","caller":"traceutil/trace.go:171","msg":"trace[327921868] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"134.580341ms","start":"2026-08-22T10:28:19.730247Z","end":"2026-08-22T10:28:19.864827Z","steps":["trace[327921868] 'process raft request' (duration: 134.333926ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:19.914691Z","caller":"traceutil/trace.go:171","msg":"trace[2124700135] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"166.027474ms","start":"2026-08-22T10:28:19.748639Z","end":"2026-08-22T10:28:19.914666Z","steps":["trace[2124700135] 'process raft request' (duration: 161.695219ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:22.411137Z","caller":"traceutil/trace.go:171","msg":"trace[176316364] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"193.727721ms","start":"2026-08-22T10:28:22.21739Z","end":"2026-08-22T10:28:22.411117Z","steps":["trace[176316364] 'read index received' (duration: 192.89489ms)","trace[176316364] 'applied index is now lower than readState.Index' (duration: 831.901µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:28:22.411325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.893201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:28:22.411244Z","caller":"traceutil/trace.go:171","msg":"trace[133670431] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"200.852093ms","start":"2026-08-22T10:28:22.210356Z","end":"2026-08-22T10:28:22.411208Z","steps":["trace[133670431] 'process raft request' (duration: 200.183741ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:22.411375Z","caller":"traceutil/trace.go:171","msg":"trace[342169622] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:613; }","duration":"193.963585ms","start":"2026-08-22T10:28:22.217401Z","end":"2026-08-22T10:28:22.411364Z","steps":["trace[342169622] 'agreement among raft nodes before linearized reading' (duration: 193.87171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:28:22.411373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.940254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:28:22.411527Z","caller":"traceutil/trace.go:171","msg":"trace[1623712895] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:613; }","duration":"194.132186ms","start":"2026-08-22T10:28:22.217374Z","end":"2026-08-22T10:28:22.411506Z","steps":["trace[1623712895] 'agreement among raft nodes before linearized reading' (duration: 193.896572ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:24.968918Z","caller":"traceutil/trace.go:171","msg":"trace[1732249665] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"154.443473ms","start":"2026-08-22T10:28:24.814417Z","end":"2026-08-22T10:28:24.96886Z","steps":["trace[1732249665] 'process raft request' (duration: 153.560668ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:25.527274Z","caller":"traceutil/trace.go:171","msg":"trace[2033495235] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"505.597454ms","start":"2026-08-22T10:28:25.021647Z","end":"2026-08-22T10:28:25.527244Z","steps":["trace[2033495235] 'process raft request' (duration: 461.703193ms)","trace[2033495235] 'compare' (duration: 43.71634ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:28:25.527909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:28:25.021624Z","time spent":"505.724513ms","remote":"127.0.0.1:44320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:28:25.555062Z","caller":"traceutil/trace.go:171","msg":"trace[58006815] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"166.008773ms","start":"2026-08-22T10:28:25.389021Z","end":"2026-08-22T10:28:25.555029Z","steps":["trace[58006815] 'process raft request' (duration: 165.747257ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:28:43.182711Z","caller":"traceutil/trace.go:171","msg":"trace[1706537703] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"105.581453ms","start":"2026-08-22T10:28:43.077103Z","end":"2026-08-22T10:28:43.182685Z","steps":["trace[1706537703] 'process raft request' (duration: 105.396565ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:29:16.343833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.80049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:29:16.343919Z","caller":"traceutil/trace.go:171","msg":"trace[221792282] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1217; }","duration":"167.935273ms","start":"2026-08-22T10:29:16.175966Z","end":"2026-08-22T10:29:16.343901Z","steps":["trace[221792282] 'count revisions from in-memory index tree' (duration: 167.718909ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:04.527657Z","caller":"traceutil/trace.go:171","msg":"trace[1612142932] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"114.275349ms","start":"2026-08-22T10:30:04.413343Z","end":"2026-08-22T10:30:04.527619Z","steps":["trace[1612142932] 'process raft request' (duration: 114.05236ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:04.527713Z","caller":"traceutil/trace.go:171","msg":"trace[719200434] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"113.588982ms","start":"2026-08-22T10:30:04.414093Z","end":"2026-08-22T10:30:04.527682Z","steps":["trace[719200434] 'process raft request' (duration: 113.449866ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:04.686934Z","caller":"traceutil/trace.go:171","msg":"trace[1673832777] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"153.463344ms","start":"2026-08-22T10:30:04.533429Z","end":"2026-08-22T10:30:04.686892Z","steps":["trace[1673832777] 'process raft request' (duration: 153.428693ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:04.687016Z","caller":"traceutil/trace.go:171","msg":"trace[1067686633] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"153.744866ms","start":"2026-08-22T10:30:04.53323Z","end":"2026-08-22T10:30:04.686975Z","steps":["trace[1067686633] 'process raft request' (duration: 91.006533ms)","trace[1067686633] 'compare' (duration: 62.520484ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:04.687653Z","caller":"traceutil/trace.go:171","msg":"trace[2072839825] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1928; }","duration":"130.091503ms","start":"2026-08-22T10:30:04.557553Z","end":"2026-08-22T10:30:04.687644Z","steps":["trace[2072839825] 'read index received' (duration: 66.724355ms)","trace[2072839825] 'applied index is now lower than readState.Index' (duration: 63.366638ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:30:04.687752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.187287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:175"} {"level":"info","ts":"2026-08-22T10:30:04.687771Z","caller":"traceutil/trace.go:171","msg":"trace[1995656094] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:1857; }","duration":"130.241669ms","start":"2026-08-22T10:30:04.557525Z","end":"2026-08-22T10:30:04.687767Z","steps":["trace[1995656094] 'agreement among raft nodes before linearized reading' (duration: 130.152155ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:04.687773Z","caller":"traceutil/trace.go:171","msg":"trace[94299131] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"137.736484ms","start":"2026-08-22T10:30:04.550016Z","end":"2026-08-22T10:30:04.687753Z","steps":["trace[94299131] 'process raft request' (duration: 137.541556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:06.275558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.934587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-22T10:30:06.275677Z","caller":"traceutil/trace.go:171","msg":"trace[67352632] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"316.103773ms","start":"2026-08-22T10:30:05.959545Z","end":"2026-08-22T10:30:06.275649Z","steps":["trace[67352632] 'range keys from in-memory index tree' (duration: 315.736859ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:06.275678Z","caller":"traceutil/trace.go:171","msg":"trace[1073000978] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"209.85898ms","start":"2026-08-22T10:30:06.065767Z","end":"2026-08-22T10:30:06.275626Z","steps":["trace[1073000978] 'process raft request' (duration: 160.089656ms)","trace[1073000978] 'compare' (duration: 49.609168ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:30:06.275731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:05.959523Z","time spent":"316.194507ms","remote":"127.0.0.1:42516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-22T10:30:06.280806Z","caller":"traceutil/trace.go:171","msg":"trace[1263428020] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"201.415602ms","start":"2026-08-22T10:30:06.079372Z","end":"2026-08-22T10:30:06.280787Z","steps":["trace[1263428020] 'process raft request' (duration: 201.293487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:06.281125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.548716ms","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-08-22T10:30:06.281165Z","caller":"traceutil/trace.go:171","msg":"trace[1775147804] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1885; }","duration":"199.594157ms","start":"2026-08-22T10:30:06.081561Z","end":"2026-08-22T10:30:06.281155Z","steps":["trace[1775147804] 'agreement among raft nodes before linearized reading' (duration: 199.454782ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:06.281418Z","caller":"traceutil/trace.go:171","msg":"trace[859298845] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1958; }","duration":"199.41378ms","start":"2026-08-22T10:30:06.081575Z","end":"2026-08-22T10:30:06.280989Z","steps":["trace[859298845] 'read index received' (duration: 144.446011ms)","trace[859298845] 'applied index is now lower than readState.Index' (duration: 54.966218ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:30:06.282396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.393608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be9c2b5a-bac4-4562-b30a-7cf0d8c810eb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-22T10:30:06.282441Z","caller":"traceutil/trace.go:171","msg":"trace[1032637109] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be9c2b5a-bac4-4562-b30a-7cf0d8c810eb; range_end:; response_count:1; response_revision:1885; }","duration":"183.463531ms","start":"2026-08-22T10:30:06.098966Z","end":"2026-08-22T10:30:06.28243Z","steps":["trace[1032637109] 'agreement among raft nodes before linearized reading' (duration: 182.985041ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:39.457272Z","caller":"traceutil/trace.go:171","msg":"trace[1750087296] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"109.585574ms","start":"2026-08-22T10:30:39.347656Z","end":"2026-08-22T10:30:39.457241Z","steps":["trace[1750087296] 'process raft request' (duration: 99.101324ms)","trace[1750087296] 'compare' (duration: 10.2903ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:30:40.138262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.963163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ce19f3522d8751\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-22T10:30:40.138355Z","caller":"traceutil/trace.go:171","msg":"trace[66110820] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ce19f3522d8751; range_end:; response_count:1; response_revision:2124; }","duration":"174.10016ms","start":"2026-08-22T10:30:39.964233Z","end":"2026-08-22T10:30:40.138333Z","steps":["trace[66110820] 'range keys from in-memory index tree' (duration: 173.539693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:40.138546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.83004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-22T10:30:40.138592Z","caller":"traceutil/trace.go:171","msg":"trace[1778952812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2124; }","duration":"206.923614ms","start":"2026-08-22T10:30:39.931655Z","end":"2026-08-22T10:30:40.138579Z","steps":["trace[1778952812] 'range keys from in-memory index tree' (duration: 206.170427ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:40.291886Z","caller":"traceutil/trace.go:171","msg":"trace[891003771] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"149.444535ms","start":"2026-08-22T10:30:40.142399Z","end":"2026-08-22T10:30:40.291844Z","steps":["trace[891003771] 'process raft request' (duration: 135.846312ms)","trace[891003771] 'compare' (duration: 13.475097ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:40.54381Z","caller":"traceutil/trace.go:171","msg":"trace[1504441865] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"135.021472ms","start":"2026-08-22T10:30:40.408766Z","end":"2026-08-22T10:30:40.543787Z","steps":["trace[1504441865] 'process raft request' (duration: 134.881855ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:40.544153Z","caller":"traceutil/trace.go:171","msg":"trace[2104587431] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"120.495744ms","start":"2026-08-22T10:30:40.423642Z","end":"2026-08-22T10:30:40.544138Z","steps":["trace[2104587431] 'process raft request' (duration: 120.110195ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:18.007523Z","caller":"traceutil/trace.go:171","msg":"trace[2001060392] linearizableReadLoop","detail":"{readStateIndex:2863; appliedIndex:2862; }","duration":"163.276349ms","start":"2026-08-22T10:32:17.844221Z","end":"2026-08-22T10:32:18.007497Z","steps":["trace[2001060392] 'read index received' (duration: 163.050296ms)","trace[2001060392] 'applied index is now lower than readState.Index' (duration: 224.933µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:18.007862Z","caller":"traceutil/trace.go:171","msg":"trace[1263675538] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"204.887331ms","start":"2026-08-22T10:32:17.802961Z","end":"2026-08-22T10:32:18.007849Z","steps":["trace[1263675538] 'process raft request' (duration: 204.313778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:18.00824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.012011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:32:18.008284Z","caller":"traceutil/trace.go:171","msg":"trace[1684457501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2758; }","duration":"164.125167ms","start":"2026-08-22T10:32:17.844147Z","end":"2026-08-22T10:32:18.008272Z","steps":["trace[1684457501] 'agreement among raft nodes before linearized reading' (duration: 164.051353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:18.008289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.845213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ce1a06a19f9030\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-08-22T10:32:18.008382Z","caller":"traceutil/trace.go:171","msg":"trace[1136323649] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ce1a06a19f9030; range_end:; response_count:1; response_revision:2758; }","duration":"109.982761ms","start":"2026-08-22T10:32:17.898371Z","end":"2026-08-22T10:32:18.008353Z","steps":["trace[1136323649] 'agreement among raft nodes before linearized reading' (duration: 109.596889ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:18.175426Z","caller":"traceutil/trace.go:171","msg":"trace[1104988177] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"162.48883ms","start":"2026-08-22T10:32:18.012918Z","end":"2026-08-22T10:32:18.175406Z","steps":["trace[1104988177] 'process raft request' (duration: 162.424566ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:18.175599Z","caller":"traceutil/trace.go:171","msg":"trace[647256137] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"164.2407ms","start":"2026-08-22T10:32:18.011351Z","end":"2026-08-22T10:32:18.175591Z","steps":["trace[647256137] 'process raft request' (duration: 125.247946ms)","trace[647256137] 'compare' (duration: 38.631074ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:18.175777Z","caller":"traceutil/trace.go:171","msg":"trace[912476316] linearizableReadLoop","detail":"{readStateIndex:2864; appliedIndex:2863; }","duration":"163.827576ms","start":"2026-08-22T10:32:18.011942Z","end":"2026-08-22T10:32:18.17577Z","steps":["trace[912476316] 'read index received' (duration: 124.682163ms)","trace[912476316] 'applied index is now lower than readState.Index' (duration: 39.144583ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:32:18.175918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.966314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-22T10:32:18.175945Z","caller":"traceutil/trace.go:171","msg":"trace[153410588] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2761; }","duration":"164.06401ms","start":"2026-08-22T10:32:18.011875Z","end":"2026-08-22T10:32:18.175939Z","steps":["trace[153410588] 'agreement among raft nodes before linearized reading' (duration: 163.922852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:59.646902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.924518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:35:59.646997Z","caller":"traceutil/trace.go:171","msg":"trace[1910523444] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4866; }","duration":"223.107484ms","start":"2026-08-22T10:35:59.423875Z","end":"2026-08-22T10:35:59.646983Z","steps":["trace[1910523444] 'read index received' (duration: 57.74416ms)","trace[1910523444] 'applied index is now lower than readState.Index' (duration: 165.362124ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:35:59.647144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.27388ms","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-08-22T10:35:59.647618Z","caller":"traceutil/trace.go:171","msg":"trace[1141440908] 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:4690; }","duration":"223.776889ms","start":"2026-08-22T10:35:59.423824Z","end":"2026-08-22T10:35:59.647601Z","steps":["trace[1141440908] 'agreement among raft nodes before linearized reading' (duration: 223.215248ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:59.647425Z","caller":"traceutil/trace.go:171","msg":"trace[367049154] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"291.512922ms","start":"2026-08-22T10:35:59.355879Z","end":"2026-08-22T10:35:59.647392Z","steps":["trace[367049154] 'process raft request' (duration: 125.809685ms)","trace[367049154] 'compare' (duration: 164.564575ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:36:11.951286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.227475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T10:36:11.951443Z","caller":"traceutil/trace.go:171","msg":"trace[1936550894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4858; }","duration":"121.433323ms","start":"2026-08-22T10:36:11.829991Z","end":"2026-08-22T10:36:11.951424Z","steps":["trace[1936550894] 'range keys from in-memory index tree' (duration: 120.979855ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:12.238845Z","caller":"traceutil/trace.go:171","msg":"trace[549873507] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"280.759584ms","start":"2026-08-22T10:36:11.958055Z","end":"2026-08-22T10:36:12.238814Z","steps":["trace[549873507] 'process raft request' (duration: 280.575637ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:12.335989Z","caller":"traceutil/trace.go:171","msg":"trace[1822429564] linearizableReadLoop","detail":"{readStateIndex:5045; appliedIndex:5042; }","duration":"250.672803ms","start":"2026-08-22T10:36:12.0853Z","end":"2026-08-22T10:36:12.335972Z","steps":["trace[1822429564] 'read index received' (duration: 153.319101ms)","trace[1822429564] 'applied index is now lower than readState.Index' (duration: 97.353042ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:36:12.336331Z","caller":"traceutil/trace.go:171","msg":"trace[2020106239] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"372.970578ms","start":"2026-08-22T10:36:11.963349Z","end":"2026-08-22T10:36:12.33632Z","steps":["trace[2020106239] 'process raft request' (duration: 357.246799ms)","trace[2020106239] 'compare' (duration: 14.962739ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:36:12.336481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:36:11.963335Z","time spent":"373.027901ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:36:12.336759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.766881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-08-22T10:36:12.336754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.438683ms","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-08-22T10:36:12.33679Z","caller":"traceutil/trace.go:171","msg":"trace[1132906523] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4861; }","duration":"167.841334ms","start":"2026-08-22T10:36:12.168941Z","end":"2026-08-22T10:36:12.336783Z","steps":["trace[1132906523] 'agreement among raft nodes before linearized reading' (duration: 167.73183ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:12.33692Z","caller":"traceutil/trace.go:171","msg":"trace[1183650504] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"311.561003ms","start":"2026-08-22T10:36:12.025332Z","end":"2026-08-22T10:36:12.336893Z","steps":["trace[1183650504] 'process raft request' (duration: 310.598016ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:12.336995Z","caller":"traceutil/trace.go:171","msg":"trace[1214380509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4861; }","duration":"251.538027ms","start":"2026-08-22T10:36:12.08528Z","end":"2026-08-22T10:36:12.336818Z","steps":["trace[1214380509] 'agreement among raft nodes before linearized reading' (duration: 251.182883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:36:12.337064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:36:12.025311Z","time spent":"311.672507ms","remote":"127.0.0.1:44036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:37:42.652703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-08-22T10:37:42.733383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"79.216004ms","hash":3323937912,"current-db-size-bytes":54239232,"current-db-size":"54 MB","current-db-size-in-use-bytes":29675520,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T10:37:42.733461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3323937912,"revision":2891,"compact-revision":-1} {"level":"info","ts":"2026-08-22T10:42:42.657827Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5621} {"level":"info","ts":"2026-08-22T10:42:42.732409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5621,"took":"73.287161ms","hash":3127979953,"current-db-size-bytes":54239232,"current-db-size":"54 MB","current-db-size-in-use-bytes":18386944,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-22T10:42:42.73247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3127979953,"revision":5621,"compact-revision":2891}