{"level":"warn","ts":"2026-04-14T09:58:18.677059Z","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-14T09:58:18.677187Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.228: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.19.213.228:2380","--initial-cluster=instance=https://199.19.213.228:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.228:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.228: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-14T09:58:18.67728Z","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-14T09:58:18.677302Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.228:2380"]} {"level":"info","ts":"2026-04-14T09:58:18.677328Z","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-14T09:58:18.678159Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"]} {"level":"info","ts":"2026-04-14T09:58:18.67826Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.228:2380"],"listen-peer-urls":["https://199.19.213.228:2380"],"advertise-client-urls":["https://199.19.213.228:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.228: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-14T09:58:18.684071Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.56516ms"} {"level":"info","ts":"2026-04-14T09:58:18.693883Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db79120667ce701f","cluster-id":"793c581eb68f3646"} {"level":"info","ts":"2026-04-14T09:58:18.694028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T09:58:18.69406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became follower at term 0"} {"level":"info","ts":"2026-04-14T09:58:18.694089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db79120667ce701f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T09:58:18.694104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became follower at term 1"} {"level":"info","ts":"2026-04-14T09:58:18.694167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=(15814691385208893471)"} {"level":"warn","ts":"2026-04-14T09:58:18.701228Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T09:58:18.702726Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T09:58:18.70421Z","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-14T09:58:18.706388Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db79120667ce701f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T09:58:18.70692Z","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-14T09:58:18.706953Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db79120667ce701f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T09:58:18.707056Z","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-14T09:58:18.707077Z","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-14T09:58:18.707964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=(15814691385208893471)"} {"level":"info","ts":"2026-04-14T09:58:18.708874Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"793c581eb68f3646","local-member-id":"db79120667ce701f","added-peer-id":"db79120667ce701f","added-peer-peer-urls":["https://199.19.213.228:2380"]} {"level":"info","ts":"2026-04-14T09:58:18.710504Z","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-14T09:58:18.710637Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.228:2380"} {"level":"info","ts":"2026-04-14T09:58:18.710674Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.228:2380"} {"level":"info","ts":"2026-04-14T09:58:18.710771Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db79120667ce701f","initial-advertise-peer-urls":["https://199.19.213.228:2380"],"listen-peer-urls":["https://199.19.213.228:2380"],"advertise-client-urls":["https://199.19.213.228:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T09:58:18.710891Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T09:58:18.995157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T09:58:18.995219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T09:58:18.995263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f received MsgPreVoteResp from db79120667ce701f at term 1"} {"level":"info","ts":"2026-04-14T09:58:18.995288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became candidate at term 2"} {"level":"info","ts":"2026-04-14T09:58:18.995311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f received MsgVoteResp from db79120667ce701f at term 2"} {"level":"info","ts":"2026-04-14T09:58:18.995334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became leader at term 2"} {"level":"info","ts":"2026-04-14T09:58:18.995353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db79120667ce701f elected leader db79120667ce701f at term 2"} {"level":"info","ts":"2026-04-14T09:58:18.996373Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db79120667ce701f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.228:2379]}","request-path":"/0/members/db79120667ce701f/attributes","cluster-id":"793c581eb68f3646","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T09:58:18.996389Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T09:58:18.996607Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T09:58:18.997108Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T09:58:18.997135Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T09:58:19.000049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.228:2379"} {"level":"info","ts":"2026-04-14T09:58:19.000207Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T09:58:19.002675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T09:58:19.003092Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"793c581eb68f3646","local-member-id":"db79120667ce701f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T09:58:19.003228Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T09:58:19.003266Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T09:58:25.461706Z","caller":"traceutil/trace.go:171","msg":"trace[1519653435] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:328; }","duration":"132.72341ms","start":"2026-04-14T09:58:25.328956Z","end":"2026-04-14T09:58:25.461679Z","steps":["trace[1519653435] 'read index received' (duration: 132.512654ms)","trace[1519653435] 'applied index is now lower than readState.Index' (duration: 209.866µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T09:58:25.461779Z","caller":"traceutil/trace.go:171","msg":"trace[1246380645] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"139.870632ms","start":"2026-04-14T09:58:25.32187Z","end":"2026-04-14T09:58:25.46174Z","steps":["trace[1246380645] 'process raft request' (duration: 139.649476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:25.46187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.884874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T09:58:25.461964Z","caller":"traceutil/trace.go:171","msg":"trace[1577789883] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:317; }","duration":"133.024938ms","start":"2026-04-14T09:58:25.328919Z","end":"2026-04-14T09:58:25.461944Z","steps":["trace[1577789883] 'agreement among raft nodes before linearized reading' (duration: 132.865323ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:35.097894Z","caller":"traceutil/trace.go:171","msg":"trace[1735703615] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"231.609298ms","start":"2026-04-14T09:58:34.866268Z","end":"2026-04-14T09:58:35.097877Z","steps":["trace[1735703615] 'read index received' (duration: 231.437073ms)","trace[1735703615] 'applied index is now lower than readState.Index' (duration: 171.685µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T09:58:35.098112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.460618ms","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-14T09:58:35.098158Z","caller":"traceutil/trace.go:171","msg":"trace[440932277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"216.550171ms","start":"2026-04-14T09:58:34.8816Z","end":"2026-04-14T09:58:35.09815Z","steps":["trace[440932277] 'agreement among raft nodes before linearized reading' (duration: 216.471789ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:35.098066Z","caller":"traceutil/trace.go:171","msg":"trace[759782766] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"336.294841ms","start":"2026-04-14T09:58:34.761735Z","end":"2026-04-14T09:58:35.09803Z","steps":["trace[759782766] 'process raft request' (duration: 336.034114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:35.098183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.898315ms","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-14T09:58:35.098331Z","caller":"traceutil/trace.go:171","msg":"trace[1836495249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"232.044559ms","start":"2026-04-14T09:58:34.866215Z","end":"2026-04-14T09:58:35.09826Z","steps":["trace[1836495249] 'agreement among raft nodes before linearized reading' (duration: 231.863614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:35.098937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:34.761719Z","time spent":"336.505836ms","remote":"127.0.0.1:56274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T09:58:35.379843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.182183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T09:58:35.379979Z","caller":"traceutil/trace.go:171","msg":"trace[423329512] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"277.270329ms","start":"2026-04-14T09:58:35.102688Z","end":"2026-04-14T09:58:35.379958Z","steps":["trace[423329512] 'process raft request' (duration: 84.661454ms)","trace[423329512] 'compare' (duration: 192.04321ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T09:58:35.380073Z","caller":"traceutil/trace.go:171","msg":"trace[638449563] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"276.321363ms","start":"2026-04-14T09:58:35.103735Z","end":"2026-04-14T09:58:35.380056Z","steps":["trace[638449563] 'process raft request' (duration: 276.280251ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:35.380081Z","caller":"traceutil/trace.go:171","msg":"trace[1709967639] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"276.363724ms","start":"2026-04-14T09:58:35.103684Z","end":"2026-04-14T09:58:35.380048Z","steps":["trace[1709967639] 'read index received' (duration: 83.673927ms)","trace[1709967639] 'applied index is now lower than readState.Index' (duration: 192.686667ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T09:58:35.380162Z","caller":"traceutil/trace.go:171","msg":"trace[67387618] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"276.415436ms","start":"2026-04-14T09:58:35.10372Z","end":"2026-04-14T09:58:35.380135Z","steps":["trace[67387618] 'process raft request' (duration: 276.241641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:35.380294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.002606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-14T09:58:35.380337Z","caller":"traceutil/trace.go:171","msg":"trace[2001605707] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:414; }","duration":"262.083079ms","start":"2026-04-14T09:58:35.118243Z","end":"2026-04-14T09:58:35.380326Z","steps":["trace[2001605707] 'agreement among raft nodes before linearized reading' (duration: 261.985856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:35.380325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.608951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-14T09:58:35.380431Z","caller":"traceutil/trace.go:171","msg":"trace[929551539] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:414; }","duration":"276.772005ms","start":"2026-04-14T09:58:35.103632Z","end":"2026-04-14T09:58:35.380404Z","steps":["trace[929551539] 'agreement among raft nodes before linearized reading' (duration: 276.548719ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:48.993663Z","caller":"traceutil/trace.go:171","msg":"trace[1046567762] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"190.833047ms","start":"2026-04-14T09:58:48.802812Z","end":"2026-04-14T09:58:48.993645Z","steps":["trace[1046567762] 'process raft request' (duration: 190.743095ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:48.99379Z","caller":"traceutil/trace.go:171","msg":"trace[844926397] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"192.02518ms","start":"2026-04-14T09:58:48.801714Z","end":"2026-04-14T09:58:48.993739Z","steps":["trace[844926397] 'process raft request' (duration: 176.410889ms)","trace[844926397] 'compare' (duration: 15.290722ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T09:58:48.993885Z","caller":"traceutil/trace.go:171","msg":"trace[200814392] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"177.591671ms","start":"2026-04-14T09:58:48.816248Z","end":"2026-04-14T09:58:48.99384Z","steps":["trace[200814392] 'process raft request' (duration: 177.362694ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:49.409586Z","caller":"traceutil/trace.go:171","msg":"trace[220184898] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"271.353249ms","start":"2026-04-14T09:58:49.138209Z","end":"2026-04-14T09:58:49.409563Z","steps":["trace[220184898] 'process raft request' (duration: 178.959816ms)","trace[220184898] 'compare' (duration: 92.281009ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T09:58:49.413623Z","caller":"traceutil/trace.go:171","msg":"trace[242993453] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"234.384903ms","start":"2026-04-14T09:58:49.179215Z","end":"2026-04-14T09:58:49.4136Z","steps":["trace[242993453] 'process raft request' (duration: 234.255989ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:49.413648Z","caller":"traceutil/trace.go:171","msg":"trace[2125804042] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"275.005727ms","start":"2026-04-14T09:58:49.138621Z","end":"2026-04-14T09:58:49.413626Z","steps":["trace[2125804042] 'process raft request' (duration: 274.714339ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:51.695321Z","caller":"traceutil/trace.go:171","msg":"trace[1137044465] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"127.035936ms","start":"2026-04-14T09:58:51.568257Z","end":"2026-04-14T09:58:51.695292Z","steps":["trace[1137044465] 'process raft request' (duration: 126.857131ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:51.696477Z","caller":"traceutil/trace.go:171","msg":"trace[109207903] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"127.047426ms","start":"2026-04-14T09:58:51.569417Z","end":"2026-04-14T09:58:51.696464Z","steps":["trace[109207903] 'process raft request' (duration: 126.972784ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:51.696524Z","caller":"traceutil/trace.go:171","msg":"trace[1654621596] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"127.715474ms","start":"2026-04-14T09:58:51.568769Z","end":"2026-04-14T09:58:51.696484Z","steps":["trace[1654621596] 'process raft request' (duration: 127.534049ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:55.317563Z","caller":"traceutil/trace.go:171","msg":"trace[1767645910] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"180.395524ms","start":"2026-04-14T09:58:55.137138Z","end":"2026-04-14T09:58:55.317534Z","steps":["trace[1767645910] 'process raft request' (duration: 179.802699ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:55.509057Z","caller":"traceutil/trace.go:171","msg":"trace[1750159769] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"123.230874ms","start":"2026-04-14T09:58:55.385795Z","end":"2026-04-14T09:58:55.509026Z","steps":["trace[1750159769] 'process raft request' (duration: 101.154918ms)","trace[1750159769] 'compare' (duration: 21.933432ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T09:58:56.269442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.941274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-14T09:58:56.269569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.530646ms","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-14T09:58:56.269447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.436603ms","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-14T09:58:56.26978Z","caller":"traceutil/trace.go:171","msg":"trace[1601642801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"551.839944ms","start":"2026-04-14T09:58:55.717909Z","end":"2026-04-14T09:58:56.269749Z","steps":["trace[1601642801] 'range keys from in-memory index tree' (duration: 551.181057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:56.269871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:55.717889Z","time spent":"551.967738ms","remote":"127.0.0.1:56350","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-14T09:58:56.269687Z","caller":"traceutil/trace.go:171","msg":"trace[1254897986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"551.775433ms","start":"2026-04-14T09:58:55.717885Z","end":"2026-04-14T09:58:56.269661Z","steps":["trace[1254897986] 'range keys from in-memory index tree' (duration: 551.32304ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T09:58:56.270212Z","caller":"traceutil/trace.go:171","msg":"trace[496906393] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"356.584928ms","start":"2026-04-14T09:58:55.91358Z","end":"2026-04-14T09:58:56.270164Z","steps":["trace[496906393] 'process raft request' (duration: 353.68029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:56.270385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:55.913543Z","time spent":"356.740103ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T09:58:56.270376Z","caller":"traceutil/trace.go:171","msg":"trace[986402083] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"311.624675ms","start":"2026-04-14T09:58:55.958707Z","end":"2026-04-14T09:58:56.270332Z","steps":["trace[986402083] 'read index received' (duration: 308.140511ms)","trace[986402083] 'applied index is now lower than readState.Index' (duration: 3.482374ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T09:58:56.270528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.80726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T09:58:56.27018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:55.717864Z","time spent":"552.294827ms","remote":"127.0.0.1:56350","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":"info","ts":"2026-04-14T09:58:56.270573Z","caller":"traceutil/trace.go:171","msg":"trace[209417494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"311.907763ms","start":"2026-04-14T09:58:55.958655Z","end":"2026-04-14T09:58:56.270563Z","steps":["trace[209417494] 'agreement among raft nodes before linearized reading' (duration: 311.80607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:56.270656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:55.958621Z","time spent":"312.026256ms","remote":"127.0.0.1:56112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T09:58:56.269614Z","caller":"traceutil/trace.go:171","msg":"trace[484998459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"553.174231ms","start":"2026-04-14T09:58:55.716415Z","end":"2026-04-14T09:58:56.269589Z","steps":["trace[484998459] 'range keys from in-memory index tree' (duration: 552.673717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:58:56.271011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:58:55.716395Z","time spent":"554.601799ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T09:59:22.242483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.717546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T09:59:22.242605Z","caller":"traceutil/trace.go:171","msg":"trace[476657274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"283.902542ms","start":"2026-04-14T09:59:21.958678Z","end":"2026-04-14T09:59:22.242581Z","steps":["trace[476657274] 'range keys from in-memory index tree' (duration: 283.586614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T09:59:54.19339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.147163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T09:59:54.193462Z","caller":"traceutil/trace.go:171","msg":"trace[1254162581] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1216; }","duration":"130.294937ms","start":"2026-04-14T09:59:54.063153Z","end":"2026-04-14T09:59:54.193448Z","steps":["trace[1254162581] 'count revisions from in-memory index tree' (duration: 130.050971ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:00:46.685507Z","caller":"traceutil/trace.go:171","msg":"trace[1831100339] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"148.496884ms","start":"2026-04-14T10:00:46.536934Z","end":"2026-04-14T10:00:46.685431Z","steps":["trace[1831100339] 'process raft request' (duration: 148.361541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:00:51.269182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.58988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:00:51.269302Z","caller":"traceutil/trace.go:171","msg":"trace[310597810] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2016; }","duration":"304.743241ms","start":"2026-04-14T10:00:50.964541Z","end":"2026-04-14T10:00:51.269284Z","steps":["trace[310597810] 'read index received' (duration: 41.853863ms)","trace[310597810] 'applied index is now lower than readState.Index' (duration: 262.887908ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:00:51.269396Z","caller":"traceutil/trace.go:171","msg":"trace[663187899] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"307.161757ms","start":"2026-04-14T10:00:50.962221Z","end":"2026-04-14T10:00:51.269383Z","steps":["trace[663187899] 'process raft request' (duration: 44.283099ms)","trace[663187899] 'compare' (duration: 262.390315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:00:51.269454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:50.962209Z","time spent":"307.214758ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:00:51.269665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.070863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b06c328-4234-4951-a5e6-98bd80f0d9e1\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-14T10:00:51.269752Z","caller":"traceutil/trace.go:171","msg":"trace[285405203] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b06c328-4234-4951-a5e6-98bd80f0d9e1; range_end:; response_count:1; response_revision:1945; }","duration":"111.174056ms","start":"2026-04-14T10:00:51.158557Z","end":"2026-04-14T10:00:51.269731Z","steps":["trace[285405203] 'agreement among raft nodes before linearized reading' (duration: 110.942539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:00:51.269702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.118391ms","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-14T10:00:51.269901Z","caller":"traceutil/trace.go:171","msg":"trace[1983260383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1945; }","duration":"305.331517ms","start":"2026-04-14T10:00:50.964524Z","end":"2026-04-14T10:00:51.269856Z","steps":["trace[1983260383] 'agreement among raft nodes before linearized reading' (duration: 305.005868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:00:51.26994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:50.964516Z","time spent":"305.416359ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:00:51.713183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.707127ms","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-14T10:00:51.713274Z","caller":"traceutil/trace.go:171","msg":"trace[1058684358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1946; }","duration":"268.866132ms","start":"2026-04-14T10:00:51.444387Z","end":"2026-04-14T10:00:51.713253Z","steps":["trace[1058684358] 'count revisions from in-memory index tree' (duration: 268.622385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:05.323095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.013964ms","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-04-14T10:01:05.323209Z","caller":"traceutil/trace.go:171","msg":"trace[769759034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2072; }","duration":"314.147368ms","start":"2026-04-14T10:01:05.00904Z","end":"2026-04-14T10:01:05.323187Z","steps":["trace[769759034] 'range keys from in-memory index tree' (duration: 313.822089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:05.323257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:05.008986Z","time spent":"314.261491ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:01:05.323246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.835211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-14T10:01:05.323327Z","caller":"traceutil/trace.go:171","msg":"trace[2066284223] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2072; }","duration":"279.965204ms","start":"2026-04-14T10:01:05.043344Z","end":"2026-04-14T10:01:05.323309Z","steps":["trace[2066284223] 'range keys from in-memory index tree' (duration: 279.647155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:05.323246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.832498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:01:05.323401Z","caller":"traceutil/trace.go:171","msg":"trace[1210792435] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2072; }","duration":"355.012343ms","start":"2026-04-14T10:01:04.968358Z","end":"2026-04-14T10:01:05.32337Z","steps":["trace[1210792435] 'count revisions from in-memory index tree' (duration: 354.768026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:05.323508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:04.968343Z","time spent":"355.120176ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":20,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:01:05.323648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.962212ms","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-14T10:01:05.323703Z","caller":"traceutil/trace.go:171","msg":"trace[21741602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2072; }","duration":"366.061895ms","start":"2026-04-14T10:01:04.95763Z","end":"2026-04-14T10:01:05.323692Z","steps":["trace[21741602] 'range keys from in-memory index tree' (duration: 365.759566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:05.323841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:04.957605Z","time spent":"366.226469ms","remote":"127.0.0.1:56350","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-14T10:01:42.52721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.467792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.228\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-14T10:01:42.52733Z","caller":"traceutil/trace.go:171","msg":"trace[1694096657] range","detail":"{range_begin:/registry/masterleases/199.19.213.228; range_end:; response_count:1; response_revision:2279; }","duration":"219.670457ms","start":"2026-04-14T10:01:42.307639Z","end":"2026-04-14T10:01:42.52731Z","steps":["trace[1694096657] 'range keys from in-memory index tree' (duration: 219.264677ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:01:42.853039Z","caller":"traceutil/trace.go:171","msg":"trace[1116706220] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"147.599219ms","start":"2026-04-14T10:01:42.705414Z","end":"2026-04-14T10:01:42.853013Z","steps":["trace[1116706220] 'process raft request' (duration: 147.447575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:43.339346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.430615ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:01:43.339598Z","caller":"traceutil/trace.go:171","msg":"trace[900678594] linearizableReadLoop","detail":"{readStateIndex:2370; appliedIndex:2368; }","duration":"380.431111ms","start":"2026-04-14T10:01:42.959147Z","end":"2026-04-14T10:01:43.339578Z","steps":["trace[900678594] 'read index received' (duration: 97.635086ms)","trace[900678594] 'applied index is now lower than readState.Index' (duration: 282.794705ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:01:43.339726Z","caller":"traceutil/trace.go:171","msg":"trace[1374771067] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"602.072611ms","start":"2026-04-14T10:01:42.737642Z","end":"2026-04-14T10:01:43.339714Z","steps":["trace[1374771067] 'process raft request' (duration: 319.163423ms)","trace[1374771067] 'compare' (duration: 282.066426ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:01:43.339803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:42.737619Z","time spent":"602.144623ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:01:43.339835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.666727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:01:43.339918Z","caller":"traceutil/trace.go:171","msg":"trace[568931053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2285; }","duration":"380.78561ms","start":"2026-04-14T10:01:42.95911Z","end":"2026-04-14T10:01:43.339895Z","steps":["trace[568931053] 'agreement among raft nodes before linearized reading' (duration: 380.630616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:43.339959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:42.959095Z","time spent":"380.856262ms","remote":"127.0.0.1:56096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T10:01:43.339962Z","caller":"traceutil/trace.go:171","msg":"trace[2114182791] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"453.788063ms","start":"2026-04-14T10:01:42.886139Z","end":"2026-04-14T10:01:43.339927Z","steps":["trace[2114182791] 'process raft request' (duration: 453.354041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:43.340011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.568716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"warn","ts":"2026-04-14T10:01:43.340057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:01:42.886112Z","time spent":"453.895156ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:01:43.340099Z","caller":"traceutil/trace.go:171","msg":"trace[1537964744] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2285; }","duration":"193.716989ms","start":"2026-04-14T10:01:43.146364Z","end":"2026-04-14T10:01:43.340081Z","steps":["trace[1537964744] 'agreement among raft nodes before linearized reading' (duration: 193.491083ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:01:48.666556Z","caller":"traceutil/trace.go:171","msg":"trace[13325900] linearizableReadLoop","detail":"{readStateIndex:2398; appliedIndex:2397; }","duration":"103.625606ms","start":"2026-04-14T10:01:48.562899Z","end":"2026-04-14T10:01:48.666524Z","steps":["trace[13325900] 'read index received' (duration: 103.40131ms)","trace[13325900] 'applied index is now lower than readState.Index' (duration: 223.386µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:01:48.666619Z","caller":"traceutil/trace.go:171","msg":"trace[749722105] transaction","detail":"{read_only:false; response_revision:2312; number_of_response:1; }","duration":"115.516107ms","start":"2026-04-14T10:01:48.551065Z","end":"2026-04-14T10:01:48.666581Z","steps":["trace[749722105] 'process raft request' (duration: 115.298061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:01:48.666781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.847352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:01:48.666866Z","caller":"traceutil/trace.go:171","msg":"trace[1449166293] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2312; }","duration":"103.974326ms","start":"2026-04-14T10:01:48.562874Z","end":"2026-04-14T10:01:48.666848Z","steps":["trace[1449166293] 'agreement among raft nodes before linearized reading' (duration: 103.769531ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:03:05.144606Z","caller":"traceutil/trace.go:171","msg":"trace[329586638] linearizableReadLoop","detail":"{readStateIndex:3029; appliedIndex:3028; }","duration":"186.922052ms","start":"2026-04-14T10:03:04.957657Z","end":"2026-04-14T10:03:05.14458Z","steps":["trace[329586638] 'read index received' (duration: 186.677356ms)","trace[329586638] 'applied index is now lower than readState.Index' (duration: 243.186µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:03:05.14471Z","caller":"traceutil/trace.go:171","msg":"trace[2077251106] transaction","detail":"{read_only:false; response_revision:2920; number_of_response:1; }","duration":"197.687094ms","start":"2026-04-14T10:03:04.946996Z","end":"2026-04-14T10:03:05.144683Z","steps":["trace[2077251106] 'process raft request' (duration: 197.414997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:03:05.144813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.142068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:03:05.144895Z","caller":"traceutil/trace.go:171","msg":"trace[1959383714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2920; }","duration":"187.267761ms","start":"2026-04-14T10:03:04.95761Z","end":"2026-04-14T10:03:05.144878Z","steps":["trace[1959383714] 'agreement among raft nodes before linearized reading' (duration: 187.093987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:03:05.144889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.017596ms","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-04-14T10:03:05.144954Z","caller":"traceutil/trace.go:171","msg":"trace[621376516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2920; }","duration":"119.130029ms","start":"2026-04-14T10:03:05.025808Z","end":"2026-04-14T10:03:05.144938Z","steps":["trace[621376516] 'agreement among raft nodes before linearized reading' (duration: 118.911333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:03:05.458239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.492624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:03:05.458388Z","caller":"traceutil/trace.go:171","msg":"trace[1916735781] transaction","detail":"{read_only:false; response_revision:2921; number_of_response:1; }","duration":"309.128504ms","start":"2026-04-14T10:03:05.149234Z","end":"2026-04-14T10:03:05.458363Z","steps":["trace[1916735781] 'process raft request' (duration: 77.381743ms)","trace[1916735781] 'compare' (duration: 231.328459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:03:05.458476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:03:05.149213Z","time spent":"309.223127ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:05:41.904921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.288995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-14T10:05:41.905039Z","caller":"traceutil/trace.go:171","msg":"trace[987643336] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3944; }","duration":"201.473031ms","start":"2026-04-14T10:05:41.703542Z","end":"2026-04-14T10:05:41.905015Z","steps":["trace[987643336] 'range keys from in-memory index tree' (duration: 200.808963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:05:41.905549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.219315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:05:41.905964Z","caller":"traceutil/trace.go:171","msg":"trace[1361111256] transaction","detail":"{read_only:false; response_revision:3945; number_of_response:1; }","duration":"166.163744ms","start":"2026-04-14T10:05:41.739509Z","end":"2026-04-14T10:05:41.905673Z","steps":["trace[1361111256] 'compare' (duration: 159.065401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:06:55.497924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.864297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-tls\" ","response":"range_response_count:1 size:3009"} {"level":"warn","ts":"2026-04-14T10:06:55.497943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.459904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:06:55.498025Z","caller":"traceutil/trace.go:171","msg":"trace[906492372] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:4764; }","duration":"165.019641ms","start":"2026-04-14T10:06:55.332983Z","end":"2026-04-14T10:06:55.498002Z","steps":["trace[906492372] 'range keys from in-memory index tree' (duration: 164.642701ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:06:55.498042Z","caller":"traceutil/trace.go:171","msg":"trace[1152975565] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4764; }","duration":"119.634508ms","start":"2026-04-14T10:06:55.378384Z","end":"2026-04-14T10:06:55.498019Z","steps":["trace[1152975565] 'count revisions from in-memory index tree' (duration: 119.29673ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:06:55.49816Z","caller":"traceutil/trace.go:171","msg":"trace[1403978635] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"118.6027ms","start":"2026-04-14T10:06:55.379524Z","end":"2026-04-14T10:06:55.498127Z","steps":["trace[1403978635] 'process raft request' (duration: 107.034136ms)","trace[1403978635] 'compare' (duration: 11.172423ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:04.642245Z","caller":"traceutil/trace.go:171","msg":"trace[339952210] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"157.284791ms","start":"2026-04-14T10:07:04.484869Z","end":"2026-04-14T10:07:04.642153Z","steps":["trace[339952210] 'process raft request' (duration: 156.915491ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:04.643588Z","caller":"traceutil/trace.go:171","msg":"trace[478040125] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"100.16311ms","start":"2026-04-14T10:07:04.543407Z","end":"2026-04-14T10:07:04.64357Z","steps":["trace[478040125] 'process raft request' (duration: 99.873922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.619537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.165304ms","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-14T10:07:07.619636Z","caller":"traceutil/trace.go:171","msg":"trace[888339601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5130; }","duration":"362.324199ms","start":"2026-04-14T10:07:07.257288Z","end":"2026-04-14T10:07:07.619613Z","steps":["trace[888339601] 'range keys from in-memory index tree' (duration: 361.971949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.619688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.257267Z","time spent":"362.412941ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T10:07:07.619897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.205109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-14T10:07:07.62006Z","caller":"traceutil/trace.go:171","msg":"trace[1049744276] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5130; }","duration":"378.419556ms","start":"2026-04-14T10:07:07.241632Z","end":"2026-04-14T10:07:07.620052Z","steps":["trace[1049744276] 'range keys from in-memory index tree' (duration: 377.454719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.620081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.241603Z","time spent":"378.471377ms","remote":"127.0.0.1:56292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":917,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"warn","ts":"2026-04-14T10:07:07.619862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.492703ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-14T10:07:07.61989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.940123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777681"} {"level":"info","ts":"2026-04-14T10:07:07.620622Z","caller":"traceutil/trace.go:171","msg":"trace[1290055961] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5130; }","duration":"318.717375ms","start":"2026-04-14T10:07:07.301878Z","end":"2026-04-14T10:07:07.620595Z","steps":["trace[1290055961] 'range keys from in-memory index tree' (duration: 317.035069ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:07.620665Z","caller":"traceutil/trace.go:171","msg":"trace[342367790] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"306.76326ms","start":"2026-04-14T10:07:07.31386Z","end":"2026-04-14T10:07:07.620623Z","steps":["trace[342367790] 'process raft request' (duration: 13.370893ms)","trace[342367790] 'compare' (duration: 292.297998ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:07.620699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.30186Z","time spent":"318.817847ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":777704,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-04-14T10:07:07.62083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.313848Z","time spent":"306.883723ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:07:07.621083Z","caller":"traceutil/trace.go:171","msg":"trace[282568087] linearizableReadLoop","detail":"{readStateIndex:5321; appliedIndex:5320; }","duration":"302.532265ms","start":"2026-04-14T10:07:07.318523Z","end":"2026-04-14T10:07:07.621055Z","steps":["trace[282568087] 'read index received' (duration: 8.661585ms)","trace[282568087] 'applied index is now lower than readState.Index' (duration: 293.86613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:07.646319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.966696ms","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-14T10:07:07.646377Z","caller":"traceutil/trace.go:171","msg":"trace[758095154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5131; }","duration":"314.044737ms","start":"2026-04-14T10:07:07.332318Z","end":"2026-04-14T10:07:07.646363Z","steps":["trace[758095154] 'agreement among raft nodes before linearized reading' (duration: 313.873253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.646392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.855563ms","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-14T10:07:07.646465Z","caller":"traceutil/trace.go:171","msg":"trace[381277731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5131; }","duration":"327.963076ms","start":"2026-04-14T10:07:07.31848Z","end":"2026-04-14T10:07:07.646443Z","steps":["trace[381277731] 'agreement among raft nodes before linearized reading' (duration: 302.698969ms)","trace[381277731] 'range keys from in-memory index tree' (duration: 25.101491ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:07.646521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.318462Z","time spent":"328.039848ms","remote":"127.0.0.1:56350","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-14T10:07:07.646526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.792027ms","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-14T10:07:07.646496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.726732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47d83685-7f31-4019-994b-97d5762746e6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-14T10:07:07.646559Z","caller":"traceutil/trace.go:171","msg":"trace[833842655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5131; }","duration":"318.838878ms","start":"2026-04-14T10:07:07.32771Z","end":"2026-04-14T10:07:07.646549Z","steps":["trace[833842655] 'agreement among raft nodes before linearized reading' (duration: 318.741336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.646586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.327703Z","time spent":"318.877089ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:07:07.646413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.332307Z","time spent":"314.094909ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T10:07:07.646594Z","caller":"traceutil/trace.go:171","msg":"trace[1663989767] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-47d83685-7f31-4019-994b-97d5762746e6; range_end:; response_count:1; response_revision:5131; }","duration":"326.873366ms","start":"2026-04-14T10:07:07.319699Z","end":"2026-04-14T10:07:07.646572Z","steps":["trace[1663989767] 'agreement among raft nodes before linearized reading' (duration: 326.604739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.646876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.319687Z","time spent":"327.177734ms","remote":"127.0.0.1:56274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47d83685-7f31-4019-994b-97d5762746e6\" "} {"level":"warn","ts":"2026-04-14T10:07:07.646684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.854129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:07:07.647413Z","caller":"traceutil/trace.go:171","msg":"trace[527919088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5131; }","duration":"319.390354ms","start":"2026-04-14T10:07:07.327788Z","end":"2026-04-14T10:07:07.647179Z","steps":["trace[527919088] 'agreement among raft nodes before linearized reading' (duration: 318.448248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:07.647474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:07.32777Z","time spent":"319.687171ms","remote":"127.0.0.1:42540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:07:09.879886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.361459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:07:09.880068Z","caller":"traceutil/trace.go:171","msg":"trace[593055561] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"165.657738ms","start":"2026-04-14T10:07:09.714373Z","end":"2026-04-14T10:07:09.880031Z","steps":["trace[593055561] 'process raft request' (duration: 10.002301ms)","trace[593055561] 'compare' (duration: 155.142783ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:09.881163Z","caller":"traceutil/trace.go:171","msg":"trace[1749840581] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"146.440627ms","start":"2026-04-14T10:07:09.734688Z","end":"2026-04-14T10:07:09.881129Z","steps":["trace[1749840581] 'read index received' (duration: 146.19577ms)","trace[1749840581] 'applied index is now lower than readState.Index' (duration: 242.977µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:09.881307Z","caller":"traceutil/trace.go:171","msg":"trace[1178565292] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"165.422662ms","start":"2026-04-14T10:07:09.715844Z","end":"2026-04-14T10:07:09.881267Z","steps":["trace[1178565292] 'process raft request' (duration: 165.123924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:09.881658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.94522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:07:09.881723Z","caller":"traceutil/trace.go:171","msg":"trace[872778292] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:5176; }","duration":"147.034413ms","start":"2026-04-14T10:07:09.734671Z","end":"2026-04-14T10:07:09.881705Z","steps":["trace[872778292] 'agreement among raft nodes before linearized reading' (duration: 146.626322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:09.881718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.674865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:07:09.881847Z","caller":"traceutil/trace.go:171","msg":"trace[1622518835] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:5176; }","duration":"103.792678ms","start":"2026-04-14T10:07:09.778Z","end":"2026-04-14T10:07:09.881792Z","steps":["trace[1622518835] 'agreement among raft nodes before linearized reading' (duration: 103.638074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:18.336467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.79235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:07:18.33662Z","caller":"traceutil/trace.go:171","msg":"trace[227008309] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"142.50257ms","start":"2026-04-14T10:07:18.194094Z","end":"2026-04-14T10:07:18.336596Z","steps":["trace[227008309] 'process raft request' (duration: 35.433592ms)","trace[227008309] 'compare' (duration: 106.553904ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:22.936951Z","caller":"traceutil/trace.go:171","msg":"trace[116253907] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"114.071328ms","start":"2026-04-14T10:07:22.822847Z","end":"2026-04-14T10:07:22.936919Z","steps":["trace[116253907] 'process raft request' (duration: 113.79041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.157806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.124069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:07:26.157959Z","caller":"traceutil/trace.go:171","msg":"trace[622325289] linearizableReadLoop","detail":"{readStateIndex:5710; appliedIndex:5709; }","duration":"216.089908ms","start":"2026-04-14T10:07:25.941844Z","end":"2026-04-14T10:07:26.157934Z","steps":["trace[622325289] 'read index received' (duration: 27.63835ms)","trace[622325289] 'applied index is now lower than readState.Index' (duration: 188.449727ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:26.158073Z","caller":"traceutil/trace.go:171","msg":"trace[1562119753] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"221.057413ms","start":"2026-04-14T10:07:25.936957Z","end":"2026-04-14T10:07:26.158014Z","steps":["trace[1562119753] 'process raft request' (duration: 32.617125ms)","trace[1562119753] 'compare' (duration: 187.935454ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:26.158206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.353965ms","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":"warn","ts":"2026-04-14T10:07:26.158236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.4824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:07:26.158256Z","caller":"traceutil/trace.go:171","msg":"trace[814495785] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5510; }","duration":"216.401726ms","start":"2026-04-14T10:07:25.94184Z","end":"2026-04-14T10:07:26.158242Z","steps":["trace[814495785] 'agreement among raft nodes before linearized reading' (duration: 216.233111ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.158308Z","caller":"traceutil/trace.go:171","msg":"trace[539943871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5510; }","duration":"198.596493ms","start":"2026-04-14T10:07:25.959695Z","end":"2026-04-14T10:07:26.158291Z","steps":["trace[539943871] 'agreement among raft nodes before linearized reading' (duration: 198.453699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.158326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.422947ms","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-14T10:07:26.158388Z","caller":"traceutil/trace.go:171","msg":"trace[2145199001] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5510; }","duration":"195.537939ms","start":"2026-04-14T10:07:25.962833Z","end":"2026-04-14T10:07:26.158371Z","steps":["trace[2145199001] 'agreement among raft nodes before linearized reading' (duration: 195.335554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.158482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.589291ms","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-14T10:07:26.158599Z","caller":"traceutil/trace.go:171","msg":"trace[2046444947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5510; }","duration":"195.771216ms","start":"2026-04-14T10:07:25.962801Z","end":"2026-04-14T10:07:26.158572Z","steps":["trace[2046444947] 'agreement among raft nodes before linearized reading' (duration: 195.373635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.559747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.553104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:07:26.560098Z","caller":"traceutil/trace.go:171","msg":"trace[592000153] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"167.296392ms","start":"2026-04-14T10:07:26.392781Z","end":"2026-04-14T10:07:26.560077Z","steps":["trace[592000153] 'process raft request' (duration: 167.247821ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.560107Z","caller":"traceutil/trace.go:171","msg":"trace[1580329078] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"396.691141ms","start":"2026-04-14T10:07:26.16321Z","end":"2026-04-14T10:07:26.559901Z","steps":["trace[1580329078] 'process raft request' (duration: 149.853519ms)","trace[1580329078] 'compare' (duration: 246.297088ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:26.560261Z","caller":"traceutil/trace.go:171","msg":"trace[140712041] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"396.583488ms","start":"2026-04-14T10:07:26.163646Z","end":"2026-04-14T10:07:26.56023Z","steps":["trace[140712041] 'process raft request' (duration: 396.236219ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.560325Z","caller":"traceutil/trace.go:171","msg":"trace[1680436056] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"396.157797ms","start":"2026-04-14T10:07:26.16413Z","end":"2026-04-14T10:07:26.560288Z","steps":["trace[1680436056] 'process raft request' (duration: 395.853218ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.560372Z","caller":"traceutil/trace.go:171","msg":"trace[1946563645] linearizableReadLoop","detail":"{readStateIndex:5711; appliedIndex:5710; }","duration":"396.799635ms","start":"2026-04-14T10:07:26.163517Z","end":"2026-04-14T10:07:26.560316Z","steps":["trace[1946563645] 'read index received' (duration: 149.52603ms)","trace[1946563645] 'applied index is now lower than readState.Index' (duration: 247.268324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:26.560451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.163618Z","time spent":"396.704252ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:07:26.56049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.164119Z","time spent":"396.28823ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:07:26.560696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.639102ms","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-14T10:07:26.560724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.64351ms","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-14T10:07:26.560782Z","caller":"traceutil/trace.go:171","msg":"trace[2058205809] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5514; }","duration":"223.764966ms","start":"2026-04-14T10:07:26.336998Z","end":"2026-04-14T10:07:26.560763Z","steps":["trace[2058205809] 'agreement among raft nodes before linearized reading' (duration: 223.54139ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.56081Z","caller":"traceutil/trace.go:171","msg":"trace[220946827] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5514; }","duration":"396.756203ms","start":"2026-04-14T10:07:26.164031Z","end":"2026-04-14T10:07:26.560787Z","steps":["trace[220946827] 'agreement among raft nodes before linearized reading' (duration: 396.505226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.560807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.914259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"warn","ts":"2026-04-14T10:07:26.560865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.164021Z","time spent":"396.833445ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":731,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "} {"level":"warn","ts":"2026-04-14T10:07:26.56077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.206025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-rswbz\" ","response":"range_response_count:1 size:2596"} {"level":"info","ts":"2026-04-14T10:07:26.560913Z","caller":"traceutil/trace.go:171","msg":"trace[826993910] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5514; }","duration":"365.119834ms","start":"2026-04-14T10:07:26.195758Z","end":"2026-04-14T10:07:26.560878Z","steps":["trace[826993910] 'agreement among raft nodes before linearized reading' (duration: 364.801005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.560965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.195728Z","time spent":"365.226987ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1848,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-04-14T10:07:26.56096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.163185Z","time spent":"397.074692ms","remote":"127.0.0.1:56350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:07:26.560951Z","caller":"traceutil/trace.go:171","msg":"trace[1906834187] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-rswbz; range_end:; response_count:1; response_revision:5514; }","duration":"397.437912ms","start":"2026-04-14T10:07:26.163484Z","end":"2026-04-14T10:07:26.560922Z","steps":["trace[1906834187] 'agreement among raft nodes before linearized reading' (duration: 397.00343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.561076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:07:26.163473Z","time spent":"397.589006ms","remote":"127.0.0.1:56188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":2619,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-rswbz\" "} {"level":"info","ts":"2026-04-14T10:07:26.835556Z","caller":"traceutil/trace.go:171","msg":"trace[10331863] linearizableReadLoop","detail":"{readStateIndex:5716; appliedIndex:5715; }","duration":"222.901403ms","start":"2026-04-14T10:07:26.612613Z","end":"2026-04-14T10:07:26.835515Z","steps":["trace[10331863] 'read index received' (duration: 143.534457ms)","trace[10331863] 'applied index is now lower than readState.Index' (duration: 79.364175ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:07:26.835601Z","caller":"traceutil/trace.go:171","msg":"trace[1357832003] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"269.56432ms","start":"2026-04-14T10:07:26.565977Z","end":"2026-04-14T10:07:26.835542Z","steps":["trace[1357832003] 'process raft request' (duration: 190.151894ms)","trace[1357832003] 'compare' (duration: 79.080747ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:07:26.835864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.918649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-14T10:07:26.83597Z","caller":"traceutil/trace.go:171","msg":"trace[1325585707] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5516; }","duration":"249.085514ms","start":"2026-04-14T10:07:26.58686Z","end":"2026-04-14T10:07:26.835946Z","steps":["trace[1325585707] 'agreement among raft nodes before linearized reading' (duration: 248.768286ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.839349Z","caller":"traceutil/trace.go:171","msg":"trace[450589882] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"189.28898ms","start":"2026-04-14T10:07:26.650029Z","end":"2026-04-14T10:07:26.839318Z","steps":["trace[450589882] 'process raft request' (duration: 189.156836ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:07:26.839356Z","caller":"traceutil/trace.go:171","msg":"trace[1549727732] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"212.664125ms","start":"2026-04-14T10:07:26.626643Z","end":"2026-04-14T10:07:26.839307Z","steps":["trace[1549727732] 'process raft request' (duration: 212.354516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:07:26.84034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.040725ms","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-14T10:07:26.84043Z","caller":"traceutil/trace.go:171","msg":"trace[637767923] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5520; }","duration":"220.18036ms","start":"2026-04-14T10:07:26.620229Z","end":"2026-04-14T10:07:26.840409Z","steps":["trace[637767923] 'agreement among raft nodes before linearized reading' (duration: 219.850531ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:08:08.856744Z","caller":"traceutil/trace.go:171","msg":"trace[958605760] transaction","detail":"{read_only:false; response_revision:5961; number_of_response:1; }","duration":"111.185369ms","start":"2026-04-14T10:08:08.745528Z","end":"2026-04-14T10:08:08.856714Z","steps":["trace[958605760] 'process raft request' (duration: 110.643214ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:08:19.407022Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-04-14T10:08:19.558018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"148.873526ms","hash":2704659433,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":33144832,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-14T10:08:19.558107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2704659433,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-04-14T10:12:52.995854Z","caller":"traceutil/trace.go:171","msg":"trace[1351370338] linearizableReadLoop","detail":"{readStateIndex:8217; appliedIndex:8216; }","duration":"102.57302ms","start":"2026-04-14T10:12:52.893254Z","end":"2026-04-14T10:12:52.995828Z","steps":["trace[1351370338] 'read index received' (duration: 102.246611ms)","trace[1351370338] 'applied index is now lower than readState.Index' (duration: 325.689µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:12:52.996224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.93805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T10:12:52.996253Z","caller":"traceutil/trace.go:171","msg":"trace[1388785554] transaction","detail":"{read_only:false; response_revision:7940; number_of_response:1; }","duration":"210.978668ms","start":"2026-04-14T10:12:52.78526Z","end":"2026-04-14T10:12:52.996239Z","steps":["trace[1388785554] 'process raft request' (duration: 210.33451ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:12:52.996331Z","caller":"traceutil/trace.go:171","msg":"trace[1995904258] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7940; }","duration":"103.117375ms","start":"2026-04-14T10:12:52.893188Z","end":"2026-04-14T10:12:52.996306Z","steps":["trace[1995904258] 'agreement among raft nodes before linearized reading' (duration: 102.797886ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:13:19.413712Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6026} {"level":"info","ts":"2026-04-14T10:13:19.518129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6026,"took":"101.910195ms","hash":108339114,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":21622784,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-14T10:13:19.518225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":108339114,"revision":6026,"compact-revision":3000} {"level":"info","ts":"2026-04-14T10:13:40.506381Z","caller":"traceutil/trace.go:171","msg":"trace[1822500298] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"269.655009ms","start":"2026-04-14T10:13:40.236696Z","end":"2026-04-14T10:13:40.506351Z","steps":["trace[1822500298] 'process raft request' (duration: 269.469634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:13:53.022045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.292894ms","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-14T10:13:53.022166Z","caller":"traceutil/trace.go:171","msg":"trace[301213504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8453; }","duration":"163.50519ms","start":"2026-04-14T10:13:52.858633Z","end":"2026-04-14T10:13:53.022139Z","steps":["trace[301213504] 'range keys from in-memory index tree' (duration: 162.966445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:13:53.022225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.318259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:13:53.022379Z","caller":"traceutil/trace.go:171","msg":"trace[208784091] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:8453; }","duration":"158.527955ms","start":"2026-04-14T10:13:52.863812Z","end":"2026-04-14T10:13:53.02234Z","steps":["trace[208784091] 'count revisions from in-memory index tree' (duration: 158.178195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:13:53.022514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.909127ms","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-14T10:13:53.02264Z","caller":"traceutil/trace.go:171","msg":"trace[697349489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8453; }","duration":"162.099312ms","start":"2026-04-14T10:13:52.860513Z","end":"2026-04-14T10:13:53.022612Z","steps":["trace[697349489] 'range keys from in-memory index tree' (duration: 161.529786ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:21.759176Z","caller":"traceutil/trace.go:171","msg":"trace[1734875802] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"201.164388ms","start":"2026-04-14T10:14:21.557985Z","end":"2026-04-14T10:14:21.75915Z","steps":["trace[1734875802] 'process raft request' (duration: 200.993733ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:21.972711Z","caller":"traceutil/trace.go:171","msg":"trace[922531681] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"296.541406ms","start":"2026-04-14T10:14:21.676139Z","end":"2026-04-14T10:14:21.972681Z","steps":["trace[922531681] 'process raft request' (duration: 291.774067ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:22.167066Z","caller":"traceutil/trace.go:171","msg":"trace[1622877663] linearizableReadLoop","detail":"{readStateIndex:8966; appliedIndex:8965; }","duration":"177.335283ms","start":"2026-04-14T10:14:21.98971Z","end":"2026-04-14T10:14:22.167045Z","steps":["trace[1622877663] 'read index received' (duration: 176.388018ms)","trace[1622877663] 'applied index is now lower than readState.Index' (duration: 946.265µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:14:22.16713Z","caller":"traceutil/trace.go:171","msg":"trace[1083994391] transaction","detail":"{read_only:false; response_revision:8664; number_of_response:1; }","duration":"274.732977ms","start":"2026-04-14T10:14:21.892381Z","end":"2026-04-14T10:14:22.167114Z","steps":["trace[1083994391] 'process raft request' (duration: 273.770241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:14:22.167738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.004112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228882"} {"level":"info","ts":"2026-04-14T10:14:22.167801Z","caller":"traceutil/trace.go:171","msg":"trace[1089403172] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8664; }","duration":"178.122405ms","start":"2026-04-14T10:14:21.989665Z","end":"2026-04-14T10:14:22.167787Z","steps":["trace[1089403172] 'agreement among raft nodes before linearized reading' (duration: 177.459278ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:26.92436Z","caller":"traceutil/trace.go:171","msg":"trace[709650471] transaction","detail":"{read_only:false; response_revision:8687; number_of_response:1; }","duration":"201.916438ms","start":"2026-04-14T10:14:26.722412Z","end":"2026-04-14T10:14:26.924329Z","steps":["trace[709650471] 'process raft request' (duration: 201.667031ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:27.003016Z","caller":"traceutil/trace.go:171","msg":"trace[1196892276] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"241.447996ms","start":"2026-04-14T10:14:26.76153Z","end":"2026-04-14T10:14:27.002978Z","steps":["trace[1196892276] 'process raft request' (duration: 191.598788ms)","trace[1196892276] 'compare' (duration: 49.401826ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:14:27.00316Z","caller":"traceutil/trace.go:171","msg":"trace[896902356] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"227.194691ms","start":"2026-04-14T10:14:26.775923Z","end":"2026-04-14T10:14:27.003118Z","steps":["trace[896902356] 'process raft request' (duration: 227.043127ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:14:36.864761Z","caller":"traceutil/trace.go:171","msg":"trace[1329140744] transaction","detail":"{read_only:false; response_revision:8788; number_of_response:1; }","duration":"273.576925ms","start":"2026-04-14T10:14:36.591158Z","end":"2026-04-14T10:14:36.864735Z","steps":["trace[1329140744] 'process raft request' (duration: 273.36797ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:15:02.069782Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a4.wal"} {"level":"info","ts":"2026-04-14T10:15:55.529901Z","caller":"traceutil/trace.go:171","msg":"trace[118727700] transaction","detail":"{read_only:false; response_revision:9544; number_of_response:1; }","duration":"127.847788ms","start":"2026-04-14T10:15:55.402012Z","end":"2026-04-14T10:15:55.52986Z","steps":["trace[118727700] 'process raft request' (duration: 127.662563ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:16:09.942165Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db79120667ce701f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-14T10:16:09.949535Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-14T10:16:09.949894Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-14T10:18:19.421471Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8104} {"level":"info","ts":"2026-04-14T10:18:19.489351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8104,"took":"64.773215ms","hash":2404046021,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":28200960,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-14T10:18:19.489424Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2404046021,"revision":8104,"compact-revision":6026} {"level":"info","ts":"2026-04-14T10:23:19.428858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10505} {"level":"info","ts":"2026-04-14T10:23:19.513937Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10505,"took":"82.138188ms","hash":1890120743,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":22142976,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-14T10:23:19.514021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1890120743,"revision":10505,"compact-revision":8104}