{"level":"warn","ts":"2026-04-12T08:54:02.720008Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T08:54:02.720155Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.36:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.36:2380","--initial-cluster=instance=https://162.253.55.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.36: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-04-12T08:54:02.72025Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T08:54:02.720271Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-04-12T08:54:02.720293Z","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-04-12T08:54:02.721178Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"]} {"level":"info","ts":"2026-04-12T08:54:02.721288Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.36: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-04-12T08:54:02.724907Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.288517ms"} {"level":"info","ts":"2026-04-12T08:54:02.736397Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb89ec34a9687f0b","cluster-id":"d8e0d5e222e856c9"} {"level":"info","ts":"2026-04-12T08:54:02.736538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T08:54:02.736581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 0"} {"level":"info","ts":"2026-04-12T08:54:02.736608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb89ec34a9687f0b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T08:54:02.736623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 1"} {"level":"info","ts":"2026-04-12T08:54:02.736683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"warn","ts":"2026-04-12T08:54:02.743366Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T08:54:02.744682Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T08:54:02.745812Z","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-04-12T08:54:02.747945Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb89ec34a9687f0b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T08:54:02.748175Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb89ec34a9687f0b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T08:54:02.748405Z","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-04-12T08:54:02.748619Z","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-04-12T08:54:02.748646Z","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-04-12T08:54:02.75003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"info","ts":"2026-04-12T08:54:02.7507Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","added-peer-id":"cb89ec34a9687f0b","added-peer-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-04-12T08:54:02.754569Z","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-04-12T08:54:02.754888Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb89ec34a9687f0b","initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T08:54:02.754952Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T08:54:02.755755Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-04-12T08:54:02.755831Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-04-12T08:54:03.337893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T08:54:03.337978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T08:54:03.338003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgPreVoteResp from cb89ec34a9687f0b at term 1"} {"level":"info","ts":"2026-04-12T08:54:03.338025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became candidate at term 2"} {"level":"info","ts":"2026-04-12T08:54:03.338037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgVoteResp from cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-04-12T08:54:03.338054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became leader at term 2"} {"level":"info","ts":"2026-04-12T08:54:03.338067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb89ec34a9687f0b elected leader cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-04-12T08:54:03.368607Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T08:54:03.415378Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb89ec34a9687f0b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.36:2379]}","request-path":"/0/members/cb89ec34a9687f0b/attributes","cluster-id":"d8e0d5e222e856c9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T08:54:03.415651Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T08:54:03.415725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T08:54:03.416303Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T08:54:03.416406Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T08:54:03.417824Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T08:54:03.417968Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T08:54:03.418072Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T08:54:03.419137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-12T08:54:03.420319Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.36:2379"} {"level":"info","ts":"2026-04-12T08:54:08.622473Z","caller":"traceutil/trace.go:171","msg":"trace[491625570] linearizableReadLoop","detail":"{readStateIndex:269; appliedIndex:268; }","duration":"133.850623ms","start":"2026-04-12T08:54:08.488585Z","end":"2026-04-12T08:54:08.622436Z","steps":["trace[491625570] 'read index received' (duration: 132.780651ms)","trace[491625570] 'applied index is now lower than readState.Index' (duration: 1.068342ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:54:08.622496Z","caller":"traceutil/trace.go:171","msg":"trace[1549880374] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"163.376992ms","start":"2026-04-12T08:54:08.45909Z","end":"2026-04-12T08:54:08.622467Z","steps":["trace[1549880374] 'process raft request' (duration: 162.380821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:08.622666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.058007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-12T08:54:08.622795Z","caller":"traceutil/trace.go:171","msg":"trace[573246774] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:259; }","duration":"134.260552ms","start":"2026-04-12T08:54:08.488513Z","end":"2026-04-12T08:54:08.622773Z","steps":["trace[573246774] 'agreement among raft nodes before linearized reading' (duration: 134.047388ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:14.515396Z","caller":"traceutil/trace.go:171","msg":"trace[1551383620] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"192.91244ms","start":"2026-04-12T08:54:14.322458Z","end":"2026-04-12T08:54:14.51537Z","steps":["trace[1551383620] 'process raft request' (duration: 192.691636ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.538591Z","caller":"traceutil/trace.go:171","msg":"trace[1024054117] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"131.26905ms","start":"2026-04-12T08:54:34.407297Z","end":"2026-04-12T08:54:34.538566Z","steps":["trace[1024054117] 'process raft request' (duration: 131.110867ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589471Z","caller":"traceutil/trace.go:171","msg":"trace[318200851] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"177.256048ms","start":"2026-04-12T08:54:34.412167Z","end":"2026-04-12T08:54:34.589423Z","steps":["trace[318200851] 'process raft request' (duration: 177.024804ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589521Z","caller":"traceutil/trace.go:171","msg":"trace[1026632654] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"174.798938ms","start":"2026-04-12T08:54:34.41467Z","end":"2026-04-12T08:54:34.589469Z","steps":["trace[1026632654] 'process raft request' (duration: 174.627425ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589731Z","caller":"traceutil/trace.go:171","msg":"trace[712329266] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"169.926951ms","start":"2026-04-12T08:54:34.419789Z","end":"2026-04-12T08:54:34.589716Z","steps":["trace[712329266] 'process raft request' (duration: 169.669456ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589755Z","caller":"traceutil/trace.go:171","msg":"trace[818898780] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"170.012373ms","start":"2026-04-12T08:54:34.419725Z","end":"2026-04-12T08:54:34.589738Z","steps":["trace[818898780] 'process raft request' (duration: 169.611575ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589875Z","caller":"traceutil/trace.go:171","msg":"trace[1962626152] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"170.008332ms","start":"2026-04-12T08:54:34.419842Z","end":"2026-04-12T08:54:34.589851Z","steps":["trace[1962626152] 'process raft request' (duration: 169.669195ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.5899Z","caller":"traceutil/trace.go:171","msg":"trace[131453095] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"164.41143ms","start":"2026-04-12T08:54:34.425477Z","end":"2026-04-12T08:54:34.589889Z","steps":["trace[131453095] 'process raft request' (duration: 164.083143ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.589933Z","caller":"traceutil/trace.go:171","msg":"trace[1107697795] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"162.868998ms","start":"2026-04-12T08:54:34.427051Z","end":"2026-04-12T08:54:34.58992Z","steps":["trace[1107697795] 'process raft request' (duration: 162.629114ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.590008Z","caller":"traceutil/trace.go:171","msg":"trace[554084885] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"156.937158ms","start":"2026-04-12T08:54:34.433061Z","end":"2026-04-12T08:54:34.589998Z","steps":["trace[554084885] 'process raft request' (duration: 156.762504ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.590124Z","caller":"traceutil/trace.go:171","msg":"trace[535169634] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"152.793635ms","start":"2026-04-12T08:54:34.437293Z","end":"2026-04-12T08:54:34.590087Z","steps":["trace[535169634] 'process raft request' (duration: 152.640832ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.590145Z","caller":"traceutil/trace.go:171","msg":"trace[1441480182] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"135.562496ms","start":"2026-04-12T08:54:34.454559Z","end":"2026-04-12T08:54:34.590122Z","steps":["trace[1441480182] 'process raft request' (duration: 135.454564ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.653558Z","caller":"traceutil/trace.go:171","msg":"trace[1609368333] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"107.700425ms","start":"2026-04-12T08:54:34.545803Z","end":"2026-04-12T08:54:34.653504Z","steps":["trace[1609368333] 'process raft request' (duration: 99.891997ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.653692Z","caller":"traceutil/trace.go:171","msg":"trace[1030506152] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"105.090462ms","start":"2026-04-12T08:54:34.548564Z","end":"2026-04-12T08:54:34.653655Z","steps":["trace[1030506152] 'process raft request' (duration: 104.869568ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:34.65385Z","caller":"traceutil/trace.go:171","msg":"trace[1980730881] transaction","detail":"{read_only:false; number_of_response:1; response_revision:486; }","duration":"104.580391ms","start":"2026-04-12T08:54:34.549235Z","end":"2026-04-12T08:54:34.653815Z","steps":["trace[1980730881] 'process raft request' (duration: 104.248054ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:35.112296Z","caller":"traceutil/trace.go:171","msg":"trace[568088162] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"100.658032ms","start":"2026-04-12T08:54:35.011616Z","end":"2026-04-12T08:54:35.112274Z","steps":["trace[568088162] 'process raft request' (duration: 100.602911ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:35.112365Z","caller":"traceutil/trace.go:171","msg":"trace[1433305915] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"101.52558ms","start":"2026-04-12T08:54:35.010798Z","end":"2026-04-12T08:54:35.112323Z","steps":["trace[1433305915] 'process raft request' (duration: 66.594415ms)","trace[1433305915] 'compare' (duration: 34.67749ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:54:39.830062Z","caller":"traceutil/trace.go:171","msg":"trace[1593028840] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"115.567254ms","start":"2026-04-12T08:54:39.714465Z","end":"2026-04-12T08:54:39.830032Z","steps":["trace[1593028840] 'process raft request' (duration: 115.421781ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:54:39.953773Z","caller":"traceutil/trace.go:171","msg":"trace[1369346296] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"143.208651ms","start":"2026-04-12T08:54:39.810533Z","end":"2026-04-12T08:54:39.953741Z","steps":["trace[1369346296] 'process raft request' (duration: 142.62828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:41.50128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.194309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-12T08:54:41.501379Z","caller":"traceutil/trace.go:171","msg":"trace[1639606443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"509.320852ms","start":"2026-04-12T08:54:40.992031Z","end":"2026-04-12T08:54:41.501352Z","steps":["trace[1639606443] 'range keys from in-memory index tree' (duration: 509.034516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:41.50142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:54:40.992019Z","time spent":"509.392493ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-12T08:54:41.501398Z","caller":"traceutil/trace.go:171","msg":"trace[1771051571] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"326.288617ms","start":"2026-04-12T08:54:41.175039Z","end":"2026-04-12T08:54:41.501327Z","steps":["trace[1771051571] 'read index received' (duration: 270.614493ms)","trace[1771051571] 'applied index is now lower than readState.Index' (duration: 55.671073ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:54:41.501588Z","caller":"traceutil/trace.go:171","msg":"trace[1969963642] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"454.193388ms","start":"2026-04-12T08:54:41.047331Z","end":"2026-04-12T08:54:41.501524Z","steps":["trace[1969963642] 'process raft request' (duration: 398.390162ms)","trace[1969963642] 'compare' (duration: 55.100422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T08:54:41.501895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.865139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-12T08:54:41.501936Z","caller":"traceutil/trace.go:171","msg":"trace[1970651166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"326.95004ms","start":"2026-04-12T08:54:41.174973Z","end":"2026-04-12T08:54:41.501923Z","steps":["trace[1970651166] 'agreement among raft nodes before linearized reading' (duration: 326.823887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:41.501973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:54:41.174942Z","time spent":"327.025192ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-12T08:54:41.502287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.726018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h5lts\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-12T08:54:41.502323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:54:41.047303Z","time spent":"454.396383ms","remote":"127.0.0.1:42034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-12T08:54:41.502392Z","caller":"traceutil/trace.go:171","msg":"trace[278762336] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h5lts; range_end:; response_count:1; response_revision:582; }","duration":"123.885371ms","start":"2026-04-12T08:54:41.378481Z","end":"2026-04-12T08:54:41.502367Z","steps":["trace[278762336] 'agreement among raft nodes before linearized reading' (duration: 123.570645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:41.502376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.403789ms","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-04-12T08:54:41.502508Z","caller":"traceutil/trace.go:171","msg":"trace[988107234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"324.566813ms","start":"2026-04-12T08:54:41.177917Z","end":"2026-04-12T08:54:41.502483Z","steps":["trace[988107234] 'agreement among raft nodes before linearized reading' (duration: 324.137324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:54:41.502559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:54:41.177907Z","time spent":"324.642424ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-12T08:55:29.837058Z","caller":"traceutil/trace.go:171","msg":"trace[935310008] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"168.87096ms","start":"2026-04-12T08:55:29.66816Z","end":"2026-04-12T08:55:29.837031Z","steps":["trace[935310008] 'process raft request' (duration: 168.667026ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:56:15.116411Z","caller":"traceutil/trace.go:171","msg":"trace[1603930929] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"103.857267ms","start":"2026-04-12T08:56:15.01252Z","end":"2026-04-12T08:56:15.116378Z","steps":["trace[1603930929] 'process raft request' (duration: 97.723143ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:56:15.116653Z","caller":"traceutil/trace.go:171","msg":"trace[551067937] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"104.01917ms","start":"2026-04-12T08:56:15.012609Z","end":"2026-04-12T08:56:15.116628Z","steps":["trace[551067937] 'process raft request' (duration: 103.688564ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:56:15.116959Z","caller":"traceutil/trace.go:171","msg":"trace[1749116826] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"104.281276ms","start":"2026-04-12T08:56:15.012634Z","end":"2026-04-12T08:56:15.116916Z","steps":["trace[1749116826] 'process raft request' (duration: 103.903538ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:56:28.046043Z","caller":"traceutil/trace.go:171","msg":"trace[2015902556] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"213.133265ms","start":"2026-04-12T08:56:27.83288Z","end":"2026-04-12T08:56:28.046013Z","steps":["trace[2015902556] 'process raft request' (duration: 212.932751ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:56:30.955993Z","caller":"traceutil/trace.go:171","msg":"trace[220187161] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"104.703374ms","start":"2026-04-12T08:56:30.851266Z","end":"2026-04-12T08:56:30.955969Z","steps":["trace[220187161] 'process raft request' (duration: 104.548571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.780272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.809909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T08:57:04.780396Z","caller":"traceutil/trace.go:171","msg":"trace[2044371080] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"323.432819ms","start":"2026-04-12T08:57:04.456945Z","end":"2026-04-12T08:57:04.780378Z","steps":["trace[2044371080] 'read index received' (duration: 72.881217ms)","trace[2044371080] 'applied index is now lower than readState.Index' (duration: 250.550392ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:57:04.780508Z","caller":"traceutil/trace.go:171","msg":"trace[164773408] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"340.288758ms","start":"2026-04-12T08:57:04.440183Z","end":"2026-04-12T08:57:04.780472Z","steps":["trace[164773408] 'process raft request' (duration: 225.897907ms)","trace[164773408] 'compare' (duration: 113.574145ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T08:57:04.780622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.552688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-12T08:57:04.780665Z","caller":"traceutil/trace.go:171","msg":"trace[541365112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2132; }","duration":"287.595779ms","start":"2026-04-12T08:57:04.493059Z","end":"2026-04-12T08:57:04.780654Z","steps":["trace[541365112] 'agreement among raft nodes before linearized reading' (duration: 287.426204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.780666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.489033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-12T08:57:04.780678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:57:04.440156Z","time spent":"340.428922ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T08:57:04.780766Z","caller":"traceutil/trace.go:171","msg":"trace[1572564247] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2132; }","duration":"181.616705ms","start":"2026-04-12T08:57:04.59913Z","end":"2026-04-12T08:57:04.780746Z","steps":["trace[1572564247] 'agreement among raft nodes before linearized reading' (duration: 181.37606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.780916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.973189ms","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-04-12T08:57:04.781009Z","caller":"traceutil/trace.go:171","msg":"trace[1408805828] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"229.03994ms","start":"2026-04-12T08:57:04.551903Z","end":"2026-04-12T08:57:04.780942Z","steps":["trace[1408805828] 'agreement among raft nodes before linearized reading' (duration: 228.929658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.781077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.861264ms","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-04-12T08:57:04.781196Z","caller":"traceutil/trace.go:171","msg":"trace[897916484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2132; }","duration":"287.986946ms","start":"2026-04-12T08:57:04.493196Z","end":"2026-04-12T08:57:04.781183Z","steps":["trace[897916484] 'agreement among raft nodes before linearized reading' (duration: 287.779712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.780985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.97351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-12T08:57:04.781343Z","caller":"traceutil/trace.go:171","msg":"trace[120213354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2132; }","duration":"324.43209ms","start":"2026-04-12T08:57:04.456888Z","end":"2026-04-12T08:57:04.78132Z","steps":["trace[120213354] 'agreement among raft nodes before linearized reading' (duration: 323.579012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.781416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T08:57:04.456875Z","time spent":"324.527321ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-12T08:57:04.781594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.845609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-12T08:57:04.781767Z","caller":"traceutil/trace.go:171","msg":"trace[1884685762] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2132; }","duration":"251.39896ms","start":"2026-04-12T08:57:04.53034Z","end":"2026-04-12T08:57:04.781739Z","steps":["trace[1884685762] 'agreement among raft nodes before linearized reading' (duration: 250.484332ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:57:04.960153Z","caller":"traceutil/trace.go:171","msg":"trace[1757046973] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"175.426241ms","start":"2026-04-12T08:57:04.784688Z","end":"2026-04-12T08:57:04.960114Z","steps":["trace[1757046973] 'process raft request' (duration: 155.092931ms)","trace[1757046973] 'compare' (duration: 20.076295ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:57:04.960221Z","caller":"traceutil/trace.go:171","msg":"trace[1275800816] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"175.424361ms","start":"2026-04-12T08:57:04.784771Z","end":"2026-04-12T08:57:04.960195Z","steps":["trace[1275800816] 'process raft request' (duration: 175.203366ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:57:04.960444Z","caller":"traceutil/trace.go:171","msg":"trace[309723715] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"175.114484ms","start":"2026-04-12T08:57:04.785209Z","end":"2026-04-12T08:57:04.960323Z","steps":["trace[309723715] 'process raft request' (duration: 174.856329ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:57:04.960582Z","caller":"traceutil/trace.go:171","msg":"trace[65387140] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2218; }","duration":"175.691766ms","start":"2026-04-12T08:57:04.784879Z","end":"2026-04-12T08:57:04.960571Z","steps":["trace[65387140] 'read index received' (duration: 72.286005ms)","trace[65387140] 'applied index is now lower than readState.Index' (duration: 103.404951ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:57:04.960639Z","caller":"traceutil/trace.go:171","msg":"trace[410670237] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"174.498082ms","start":"2026-04-12T08:57:04.786131Z","end":"2026-04-12T08:57:04.960629Z","steps":["trace[410670237] 'process raft request' (duration: 174.017843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:57:04.960882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.104725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-12T08:57:04.960929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.030323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25766"} {"level":"info","ts":"2026-04-12T08:57:04.960946Z","caller":"traceutil/trace.go:171","msg":"trace[683785263] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2137; }","duration":"175.211836ms","start":"2026-04-12T08:57:04.785718Z","end":"2026-04-12T08:57:04.960929Z","steps":["trace[683785263] 'agreement among raft nodes before linearized reading' (duration: 175.048353ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:57:04.960977Z","caller":"traceutil/trace.go:171","msg":"trace[183046250] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2137; }","duration":"176.093324ms","start":"2026-04-12T08:57:04.78487Z","end":"2026-04-12T08:57:04.960964Z","steps":["trace[183046250] 'agreement among raft nodes before linearized reading' (duration: 175.772757ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:57:44.871944Z","caller":"traceutil/trace.go:171","msg":"trace[421655090] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"199.830851ms","start":"2026-04-12T08:57:44.672084Z","end":"2026-04-12T08:57:44.871914Z","steps":["trace[421655090] 'process raft request' (duration: 199.582846ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:58:13.394402Z","caller":"traceutil/trace.go:171","msg":"trace[1538502187] linearizableReadLoop","detail":"{readStateIndex:2809; appliedIndex:2808; }","duration":"107.007453ms","start":"2026-04-12T08:58:13.287367Z","end":"2026-04-12T08:58:13.394375Z","steps":["trace[1538502187] 'read index received' (duration: 86.568614ms)","trace[1538502187] 'applied index is now lower than readState.Index' (duration: 20.437839ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T08:58:13.394549Z","caller":"traceutil/trace.go:171","msg":"trace[1455651482] transaction","detail":"{read_only:false; response_revision:2702; number_of_response:1; }","duration":"107.924382ms","start":"2026-04-12T08:58:13.286599Z","end":"2026-04-12T08:58:13.394523Z","steps":["trace[1455651482] 'process raft request' (duration: 87.306268ms)","trace[1455651482] 'compare' (duration: 20.361598ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T08:58:13.394801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.617765ms","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-04-12T08:58:13.394854Z","caller":"traceutil/trace.go:171","msg":"trace[1853267611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2702; }","duration":"103.687977ms","start":"2026-04-12T08:58:13.291152Z","end":"2026-04-12T08:58:13.39484Z","steps":["trace[1853267611] 'agreement among raft nodes before linearized reading' (duration: 103.560865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:58:13.39467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.282359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-12T08:58:13.394922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.171067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-12T08:58:13.395043Z","caller":"traceutil/trace.go:171","msg":"trace[1754271427] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2702; }","duration":"103.31575ms","start":"2026-04-12T08:58:13.2917Z","end":"2026-04-12T08:58:13.395015Z","steps":["trace[1754271427] 'agreement among raft nodes before linearized reading' (duration: 103.036914ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T08:58:13.39499Z","caller":"traceutil/trace.go:171","msg":"trace[2144030415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2702; }","duration":"107.616686ms","start":"2026-04-12T08:58:13.287335Z","end":"2026-04-12T08:58:13.394951Z","steps":["trace[2144030415] 'agreement among raft nodes before linearized reading' (duration: 107.191808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T08:58:19.42811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.633896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T08:58:19.428226Z","caller":"traceutil/trace.go:171","msg":"trace[248171113] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"193.266371ms","start":"2026-04-12T08:58:19.234946Z","end":"2026-04-12T08:58:19.428212Z","steps":["trace[248171113] 'process raft request' (duration: 56.472093ms)","trace[248171113] 'compare' (duration: 136.298498ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:00:55.688257Z","caller":"traceutil/trace.go:171","msg":"trace[1130340719] transaction","detail":"{read_only:false; response_revision:3756; number_of_response:1; }","duration":"113.894899ms","start":"2026-04-12T09:00:55.574333Z","end":"2026-04-12T09:00:55.688228Z","steps":["trace[1130340719] 'process raft request' (duration: 113.743366ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:19.452012Z","caller":"traceutil/trace.go:171","msg":"trace[1904087105] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"317.003967ms","start":"2026-04-12T09:02:19.134977Z","end":"2026-04-12T09:02:19.451981Z","steps":["trace[1904087105] 'process raft request' (duration: 316.805323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:19.452287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:19.134959Z","time spent":"317.146919ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T09:02:19.462351Z","caller":"traceutil/trace.go:171","msg":"trace[699981676] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5130; }","duration":"228.090266ms","start":"2026-04-12T09:02:19.234238Z","end":"2026-04-12T09:02:19.462328Z","steps":["trace[699981676] 'read index received' (duration: 217.582346ms)","trace[699981676] 'applied index is now lower than readState.Index' (duration: 10.50653ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:19.46249Z","caller":"traceutil/trace.go:171","msg":"trace[827209607] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"323.997657ms","start":"2026-04-12T09:02:19.138454Z","end":"2026-04-12T09:02:19.462452Z","steps":["trace[827209607] 'process raft request' (duration: 323.687101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:19.46263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.370962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-652c0838-d071-4117-96af-f58aed37a4a9\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-04-12T09:02:19.462667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:19.138441Z","time spent":"324.13772ms","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2499,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-12T09:02:19.462723Z","caller":"traceutil/trace.go:171","msg":"trace[20216951] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-652c0838-d071-4117-96af-f58aed37a4a9; range_end:; response_count:1; response_revision:4941; }","duration":"228.447643ms","start":"2026-04-12T09:02:19.234222Z","end":"2026-04-12T09:02:19.462669Z","steps":["trace[20216951] 'agreement among raft nodes before linearized reading' (duration: 228.237469ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:22.607636Z","caller":"traceutil/trace.go:171","msg":"trace[271128449] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"105.046254ms","start":"2026-04-12T09:02:22.502528Z","end":"2026-04-12T09:02:22.607574Z","steps":["trace[271128449] 'process raft request' (duration: 36.320278ms)","trace[271128449] 'compare' (duration: 68.323008ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T09:02:29.712141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.093255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T09:02:29.712404Z","caller":"traceutil/trace.go:171","msg":"trace[1733990612] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"168.187058ms","start":"2026-04-12T09:02:29.544197Z","end":"2026-04-12T09:02:29.712384Z","steps":["trace[1733990612] 'process raft request' (duration: 168.120726ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:29.712433Z","caller":"traceutil/trace.go:171","msg":"trace[1765384621] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"177.775789ms","start":"2026-04-12T09:02:29.534605Z","end":"2026-04-12T09:02:29.712381Z","steps":["trace[1765384621] 'process raft request' (duration: 55.339587ms)","trace[1765384621] 'compare' (duration: 121.920171ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:29.712484Z","caller":"traceutil/trace.go:171","msg":"trace[742392379] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"169.228498ms","start":"2026-04-12T09:02:29.543222Z","end":"2026-04-12T09:02:29.71245Z","steps":["trace[742392379] 'process raft request' (duration: 169.034374ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.256011Z","caller":"traceutil/trace.go:171","msg":"trace[1820405359] linearizableReadLoop","detail":"{readStateIndex:5498; appliedIndex:5497; }","duration":"173.83474ms","start":"2026-04-12T09:02:38.082151Z","end":"2026-04-12T09:02:38.255985Z","steps":["trace[1820405359] 'read index received' (duration: 173.702598ms)","trace[1820405359] 'applied index is now lower than readState.Index' (duration: 130.962µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:38.256078Z","caller":"traceutil/trace.go:171","msg":"trace[399726177] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"175.078326ms","start":"2026-04-12T09:02:38.080949Z","end":"2026-04-12T09:02:38.256027Z","steps":["trace[399726177] 'process raft request' (duration: 174.891153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.256395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.218858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-12T09:02:38.256994Z","caller":"traceutil/trace.go:171","msg":"trace[1828005118] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5297; }","duration":"174.84512ms","start":"2026-04-12T09:02:38.082132Z","end":"2026-04-12T09:02:38.256977Z","steps":["trace[1828005118] 'agreement among raft nodes before linearized reading' (duration: 173.974363ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.394371Z","caller":"traceutil/trace.go:171","msg":"trace[817367858] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"248.906514ms","start":"2026-04-12T09:02:38.145423Z","end":"2026-04-12T09:02:38.39433Z","steps":["trace[817367858] 'process raft request' (duration: 224.307781ms)","trace[817367858] 'compare' (duration: 24.381469ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:38.394646Z","caller":"traceutil/trace.go:171","msg":"trace[1334241002] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"199.678757ms","start":"2026-04-12T09:02:38.194921Z","end":"2026-04-12T09:02:38.3946Z","steps":["trace[1334241002] 'process raft request' (duration: 199.355521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.394891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.289779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4ed933a6-0bbb-478d-8952-5191f9b98036\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-12T09:02:38.39497Z","caller":"traceutil/trace.go:171","msg":"trace[443586938] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4ed933a6-0bbb-478d-8952-5191f9b98036; range_end:; response_count:1; response_revision:5299; }","duration":"168.431812ms","start":"2026-04-12T09:02:38.22652Z","end":"2026-04-12T09:02:38.394952Z","steps":["trace[443586938] 'agreement among raft nodes before linearized reading' (duration: 168.194918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.395241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.303461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kgqgz\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-12T09:02:38.395382Z","caller":"traceutil/trace.go:171","msg":"trace[1354880760] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kgqgz; range_end:; response_count:1; response_revision:5299; }","duration":"197.475255ms","start":"2026-04-12T09:02:38.197854Z","end":"2026-04-12T09:02:38.39533Z","steps":["trace[1354880760] 'agreement among raft nodes before linearized reading' (duration: 197.097826ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.394697Z","caller":"traceutil/trace.go:171","msg":"trace[529756635] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5498; }","duration":"138.510063ms","start":"2026-04-12T09:02:38.256079Z","end":"2026-04-12T09:02:38.39459Z","steps":["trace[529756635] 'read index received' (duration: 113.612054ms)","trace[529756635] 'applied index is now lower than readState.Index' (duration: 24.895329ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:38.485829Z","caller":"traceutil/trace.go:171","msg":"trace[1350253644] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"221.123447ms","start":"2026-04-12T09:02:38.264661Z","end":"2026-04-12T09:02:38.485784Z","steps":["trace[1350253644] 'process raft request' (duration: 220.858422ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.485875Z","caller":"traceutil/trace.go:171","msg":"trace[1445332619] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"220.651068ms","start":"2026-04-12T09:02:38.265177Z","end":"2026-04-12T09:02:38.485828Z","steps":["trace[1445332619] 'process raft request' (duration: 220.504525ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.485915Z","caller":"traceutil/trace.go:171","msg":"trace[1505933703] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"220.426113ms","start":"2026-04-12T09:02:38.265449Z","end":"2026-04-12T09:02:38.485875Z","steps":["trace[1505933703] 'process raft request' (duration: 220.26525ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.485989Z","caller":"traceutil/trace.go:171","msg":"trace[2128801189] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"220.081197ms","start":"2026-04-12T09:02:38.265863Z","end":"2026-04-12T09:02:38.485944Z","steps":["trace[2128801189] 'process raft request' (duration: 219.922513ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.486125Z","caller":"traceutil/trace.go:171","msg":"trace[1522144151] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"220.177339ms","start":"2026-04-12T09:02:38.265933Z","end":"2026-04-12T09:02:38.486111Z","steps":["trace[1522144151] 'process raft request' (duration: 219.892513ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.486125Z","caller":"traceutil/trace.go:171","msg":"trace[785054317] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"207.897882ms","start":"2026-04-12T09:02:38.278177Z","end":"2026-04-12T09:02:38.486075Z","steps":["trace[785054317] 'process raft request' (duration: 207.687418ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.486302Z","caller":"traceutil/trace.go:171","msg":"trace[775790233] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"220.376353ms","start":"2026-04-12T09:02:38.265535Z","end":"2026-04-12T09:02:38.485912Z","steps":["trace[775790233] 'process raft request' (duration: 220.2174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.486377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.088587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-12T09:02:38.48645Z","caller":"traceutil/trace.go:171","msg":"trace[868497138] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5306; }","duration":"223.23989ms","start":"2026-04-12T09:02:38.263189Z","end":"2026-04-12T09:02:38.486429Z","steps":["trace[868497138] 'agreement among raft nodes before linearized reading' (duration: 222.972375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.487306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.529935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"} {"level":"info","ts":"2026-04-12T09:02:38.487378Z","caller":"traceutil/trace.go:171","msg":"trace[1191821995] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5306; }","duration":"205.656657ms","start":"2026-04-12T09:02:38.281704Z","end":"2026-04-12T09:02:38.487361Z","steps":["trace[1191821995] 'agreement among raft nodes before linearized reading' (duration: 204.540745ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:02:38.672186Z","caller":"traceutil/trace.go:171","msg":"trace[723314923] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"178.329549ms","start":"2026-04-12T09:02:38.493826Z","end":"2026-04-12T09:02:38.672156Z","steps":["trace[723314923] 'process raft request' (duration: 157.008483ms)","trace[723314923] 'compare' (duration: 21.153563ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T09:02:38.909191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.497052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T09:02:38.909411Z","caller":"traceutil/trace.go:171","msg":"trace[1027138756] linearizableReadLoop","detail":"{readStateIndex:5509; appliedIndex:5507; }","duration":"413.291904ms","start":"2026-04-12T09:02:38.4961Z","end":"2026-04-12T09:02:38.909392Z","steps":["trace[1027138756] 'read index received' (duration: 154.82743ms)","trace[1027138756] 'applied index is now lower than readState.Index' (duration: 258.463244ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:02:38.909523Z","caller":"traceutil/trace.go:171","msg":"trace[972633179] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"414.860386ms","start":"2026-04-12T09:02:38.494647Z","end":"2026-04-12T09:02:38.909507Z","steps":["trace[972633179] 'process raft request' (duration: 293.891554ms)","trace[972633179] 'compare' (duration: 120.35541ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T09:02:38.909584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:38.494604Z","time spent":"414.950318ms","remote":"127.0.0.1:41700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":902,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-12T09:02:38.909942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.806444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-12T09:02:38.910057Z","caller":"traceutil/trace.go:171","msg":"trace[611418107] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5309; }","duration":"413.967537ms","start":"2026-04-12T09:02:38.496063Z","end":"2026-04-12T09:02:38.910031Z","steps":["trace[611418107] 'agreement among raft nodes before linearized reading' (duration: 413.58941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.910075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.990646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-04-12T09:02:38.910112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:38.496048Z","time spent":"414.051209ms","remote":"127.0.0.1:41798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1309,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"info","ts":"2026-04-12T09:02:38.910135Z","caller":"traceutil/trace.go:171","msg":"trace[1140862060] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5309; }","duration":"263.072868ms","start":"2026-04-12T09:02:38.64704Z","end":"2026-04-12T09:02:38.910113Z","steps":["trace[1140862060] 'agreement among raft nodes before linearized reading' (duration: 262.965586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.910192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.800089ms","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-04-12T09:02:38.910319Z","caller":"traceutil/trace.go:171","msg":"trace[2017374586] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"406.747493ms","start":"2026-04-12T09:02:38.503558Z","end":"2026-04-12T09:02:38.910306Z","steps":["trace[2017374586] 'process raft request' (duration: 405.745904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.909942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.129131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-12T09:02:38.910347Z","caller":"traceutil/trace.go:171","msg":"trace[1231350469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5309; }","duration":"143.029204ms","start":"2026-04-12T09:02:38.76729Z","end":"2026-04-12T09:02:38.910319Z","steps":["trace[1231350469] 'agreement among raft nodes before linearized reading' (duration: 142.649666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.910407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:38.503526Z","time spent":"406.824135ms","remote":"127.0.0.1:58996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T09:02:38.91038Z","caller":"traceutil/trace.go:171","msg":"trace[922632616] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5309; }","duration":"392.646862ms","start":"2026-04-12T09:02:38.517717Z","end":"2026-04-12T09:02:38.910364Z","steps":["trace[922632616] 'agreement among raft nodes before linearized reading' (duration: 391.971148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:02:38.910576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:02:38.51769Z","time spent":"392.872996ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1845,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-04-12T09:04:03.452223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-04-12T09:04:03.520862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"66.847111ms","hash":3798043343,"current-db-size-bytes":57389056,"current-db-size":"57 MB","current-db-size-in-use-bytes":33943552,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-12T09:04:03.520936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3798043343,"revision":2975,"compact-revision":-1} {"level":"warn","ts":"2026-04-12T09:08:36.200977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.125264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T09:08:36.201071Z","caller":"traceutil/trace.go:171","msg":"trace[604239783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8111; }","duration":"215.279186ms","start":"2026-04-12T09:08:35.985772Z","end":"2026-04-12T09:08:36.201051Z","steps":["trace[604239783] 'range keys from in-memory index tree' (duration: 215.027932ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:08:50.041659Z","caller":"traceutil/trace.go:171","msg":"trace[2079083930] transaction","detail":"{read_only:false; response_revision:8183; number_of_response:1; }","duration":"142.021098ms","start":"2026-04-12T09:08:49.899591Z","end":"2026-04-12T09:08:50.041612Z","steps":["trace[2079083930] 'process raft request' (duration: 140.892915ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:08:50.041998Z","caller":"traceutil/trace.go:171","msg":"trace[649766049] transaction","detail":"{read_only:false; response_revision:8184; number_of_response:1; }","duration":"114.484906ms","start":"2026-04-12T09:08:49.927492Z","end":"2026-04-12T09:08:50.041977Z","steps":["trace[649766049] 'process raft request' (duration: 114.056998ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:03.459388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6088} {"level":"info","ts":"2026-04-12T09:09:03.562695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6088,"took":"100.74644ms","hash":3478995083,"current-db-size-bytes":57389056,"current-db-size":"57 MB","current-db-size-in-use-bytes":23121920,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-12T09:09:03.562767Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3478995083,"revision":6088,"compact-revision":2975} {"level":"info","ts":"2026-04-12T09:09:18.259764Z","caller":"traceutil/trace.go:171","msg":"trace[1167098022] transaction","detail":"{read_only:false; response_revision:8392; number_of_response:1; }","duration":"131.15274ms","start":"2026-04-12T09:09:18.128584Z","end":"2026-04-12T09:09:18.259737Z","steps":["trace[1167098022] 'process raft request' (duration: 129.325663ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:18.271863Z","caller":"traceutil/trace.go:171","msg":"trace[789770862] transaction","detail":"{read_only:false; response_revision:8393; number_of_response:1; }","duration":"131.283183ms","start":"2026-04-12T09:09:18.140544Z","end":"2026-04-12T09:09:18.271827Z","steps":["trace[789770862] 'process raft request' (duration: 130.871745ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:18.272042Z","caller":"traceutil/trace.go:171","msg":"trace[1466182143] transaction","detail":"{read_only:false; response_revision:8394; number_of_response:1; }","duration":"109.25851ms","start":"2026-04-12T09:09:18.162747Z","end":"2026-04-12T09:09:18.272006Z","steps":["trace[1466182143] 'process raft request' (duration: 108.803561ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:30.74824Z","caller":"traceutil/trace.go:171","msg":"trace[1385232355] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"105.937164ms","start":"2026-04-12T09:09:30.642276Z","end":"2026-04-12T09:09:30.748213Z","steps":["trace[1385232355] 'process raft request' (duration: 105.77941ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:30.775148Z","caller":"traceutil/trace.go:171","msg":"trace[775168897] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"124.088118ms","start":"2026-04-12T09:09:30.65103Z","end":"2026-04-12T09:09:30.775118Z","steps":["trace[775168897] 'process raft request' (duration: 123.850723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:09:31.632041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.53117ms","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-04-12T09:09:31.632148Z","caller":"traceutil/trace.go:171","msg":"trace[1258382962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8502; }","duration":"208.695904ms","start":"2026-04-12T09:09:31.42343Z","end":"2026-04-12T09:09:31.632126Z","steps":["trace[1258382962] 'range keys from in-memory index tree' (duration: 208.285326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:09:31.632372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.696229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"warn","ts":"2026-04-12T09:09:31.632416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.67837ms","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-04-12T09:09:31.632481Z","caller":"traceutil/trace.go:171","msg":"trace[1777152829] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8502; }","duration":"293.883513ms","start":"2026-04-12T09:09:31.338574Z","end":"2026-04-12T09:09:31.632457Z","steps":["trace[1777152829] 'range keys from in-memory index tree' (duration: 293.408373ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:31.632536Z","caller":"traceutil/trace.go:171","msg":"trace[71811750] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8502; }","duration":"326.881294ms","start":"2026-04-12T09:09:31.305628Z","end":"2026-04-12T09:09:31.632509Z","steps":["trace[71811750] 'count revisions from in-memory index tree' (duration: 326.550457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:09:31.632601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:09:31.305598Z","time spent":"326.988775ms","remote":"127.0.0.1:36210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-12T09:09:31.632829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.609559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-12T09:09:31.632957Z","caller":"traceutil/trace.go:171","msg":"trace[95044753] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8502; }","duration":"340.785322ms","start":"2026-04-12T09:09:31.292141Z","end":"2026-04-12T09:09:31.632927Z","steps":["trace[95044753] 'range keys from in-memory index tree' (duration: 340.080229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:09:31.632886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.649456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-12T09:09:31.633035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T09:09:31.292126Z","time spent":"340.892546ms","remote":"127.0.0.1:41786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-12T09:09:31.633048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.018076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-12T09:09:31.633181Z","caller":"traceutil/trace.go:171","msg":"trace[1972594757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8502; }","duration":"255.924293ms","start":"2026-04-12T09:09:31.377146Z","end":"2026-04-12T09:09:31.63307Z","steps":["trace[1972594757] 'range keys from in-memory index tree' (duration: 254.923291ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:31.633231Z","caller":"traceutil/trace.go:171","msg":"trace[1058279733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8502; }","duration":"278.236469ms","start":"2026-04-12T09:09:31.354963Z","end":"2026-04-12T09:09:31.633199Z","steps":["trace[1058279733] 'range keys from in-memory index tree' (duration: 277.30371ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:31.670485Z","caller":"traceutil/trace.go:171","msg":"trace[137746776] linearizableReadLoop","detail":"{readStateIndex:8808; appliedIndex:8807; }","duration":"166.410737ms","start":"2026-04-12T09:09:31.504047Z","end":"2026-04-12T09:09:31.670458Z","steps":["trace[137746776] 'read index received' (duration: 166.246104ms)","trace[137746776] 'applied index is now lower than readState.Index' (duration: 162.753µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:09:31.670601Z","caller":"traceutil/trace.go:171","msg":"trace[49568972] transaction","detail":"{read_only:false; response_revision:8503; number_of_response:1; }","duration":"210.734605ms","start":"2026-04-12T09:09:31.45984Z","end":"2026-04-12T09:09:31.670575Z","steps":["trace[49568972] 'process raft request' (duration: 210.410359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T09:09:31.670975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.898067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-12T09:09:31.671037Z","caller":"traceutil/trace.go:171","msg":"trace[1837271252] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8503; }","duration":"167.018939ms","start":"2026-04-12T09:09:31.503999Z","end":"2026-04-12T09:09:31.671017Z","steps":["trace[1837271252] 'agreement among raft nodes before linearized reading' (duration: 166.605161ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:32.278881Z","caller":"traceutil/trace.go:171","msg":"trace[186009323] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"132.145969ms","start":"2026-04-12T09:09:32.146698Z","end":"2026-04-12T09:09:32.278844Z","steps":["trace[186009323] 'process raft request' (duration: 131.940485ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T09:09:44.515581Z","caller":"traceutil/trace.go:171","msg":"trace[326559754] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"109.631788ms","start":"2026-04-12T09:09:44.405906Z","end":"2026-04-12T09:09:44.515538Z","steps":["trace[326559754] 'process raft request' (duration: 45.654975ms)","trace[326559754] 'compare' (duration: 63.784019ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T09:10:22.25052Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000247c.wal"} {"level":"info","ts":"2026-04-12T09:11:44.492448Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb89ec34a9687f0b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-12T09:11:44.500463Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-12T09:11:44.500601Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-12T09:14:03.465582Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8263} {"level":"info","ts":"2026-04-12T09:14:03.545368Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8263,"took":"77.169747ms","hash":3897373736,"current-db-size-bytes":57389056,"current-db-size":"57 MB","current-db-size-in-use-bytes":24834048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-12T09:14:03.545464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3897373736,"revision":8263,"compact-revision":6088} {"level":"info","ts":"2026-04-12T09:19:03.470198Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10653} {"level":"info","ts":"2026-04-12T09:19:03.549864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10653,"took":"76.85985ms","hash":1166809635,"current-db-size-bytes":57389056,"current-db-size":"57 MB","current-db-size-in-use-bytes":20250624,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-12T09:19:03.549949Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1166809635,"revision":10653,"compact-revision":8263}