{"level":"warn","ts":"2026-04-08T10:47:56.45249Z","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-08T10:47:56.452613Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.199: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.199:2380","--initial-cluster=instance=https://199.19.213.199:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.199:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.199: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-08T10:47:56.452704Z","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-08T10:47:56.452727Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.199:2380"]} {"level":"info","ts":"2026-04-08T10:47:56.452752Z","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-08T10:47:56.453588Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"]} {"level":"info","ts":"2026-04-08T10:47:56.453678Z","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.199:2380"],"listen-peer-urls":["https://199.19.213.199:2380"],"advertise-client-urls":["https://199.19.213.199:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.199: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-08T10:47:56.457608Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.661907ms"} {"level":"info","ts":"2026-04-08T10:47:56.465611Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d660142aa1b7ce9","cluster-id":"6964c025ad43a005"} {"level":"info","ts":"2026-04-08T10:47:56.465716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T10:47:56.46574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became follower at term 0"} {"level":"info","ts":"2026-04-08T10:47:56.46576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d660142aa1b7ce9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T10:47:56.465771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became follower at term 1"} {"level":"info","ts":"2026-04-08T10:47:56.465818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=(7882989583592029417)"} {"level":"warn","ts":"2026-04-08T10:47:56.476943Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T10:47:56.479732Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T10:47:56.482618Z","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-08T10:47:56.486351Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d660142aa1b7ce9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T10:47:56.486621Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d660142aa1b7ce9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T10:47:56.486727Z","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-08T10:47:56.48687Z","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-08T10:47:56.48689Z","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-08T10:47:56.488636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=(7882989583592029417)"} {"level":"info","ts":"2026-04-08T10:47:56.48974Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6964c025ad43a005","local-member-id":"6d660142aa1b7ce9","added-peer-id":"6d660142aa1b7ce9","added-peer-peer-urls":["https://199.19.213.199:2380"]} {"level":"info","ts":"2026-04-08T10:47:56.491681Z","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-08T10:47:56.491789Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.199:2380"} {"level":"info","ts":"2026-04-08T10:47:56.491872Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.199:2380"} {"level":"info","ts":"2026-04-08T10:47:56.492052Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d660142aa1b7ce9","initial-advertise-peer-urls":["https://199.19.213.199:2380"],"listen-peer-urls":["https://199.19.213.199:2380"],"advertise-client-urls":["https://199.19.213.199:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T10:47:56.492118Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T10:47:57.167042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T10:47:57.167118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T10:47:57.167169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 received MsgPreVoteResp from 6d660142aa1b7ce9 at term 1"} {"level":"info","ts":"2026-04-08T10:47:57.1672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became candidate at term 2"} {"level":"info","ts":"2026-04-08T10:47:57.167211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 received MsgVoteResp from 6d660142aa1b7ce9 at term 2"} {"level":"info","ts":"2026-04-08T10:47:57.167228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became leader at term 2"} {"level":"info","ts":"2026-04-08T10:47:57.167248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d660142aa1b7ce9 elected leader 6d660142aa1b7ce9 at term 2"} {"level":"info","ts":"2026-04-08T10:47:57.168605Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d660142aa1b7ce9","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.199:2379]}","request-path":"/0/members/6d660142aa1b7ce9/attributes","cluster-id":"6964c025ad43a005","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T10:47:57.168613Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:57.168624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:57.168775Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:57.16898Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T10:47:57.169068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T10:47:57.169961Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6964c025ad43a005","local-member-id":"6d660142aa1b7ce9","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:57.170111Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:57.170148Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:57.170925Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T10:47:57.173119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.199:2379"} {"level":"warn","ts":"2026-04-08T10:48:35.608553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.785023ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:48:35.60884Z","caller":"traceutil/trace.go:171","msg":"trace[1446388528] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:622; }","duration":"342.101399ms","start":"2026-04-08T10:48:35.26671Z","end":"2026-04-08T10:48:35.608812Z","steps":["trace[1446388528] 'range keys from in-memory index tree' (duration: 341.757293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:35.609548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.100891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:48:35.609749Z","caller":"traceutil/trace.go:171","msg":"trace[297526063] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"430.00994ms","start":"2026-04-08T10:48:35.179717Z","end":"2026-04-08T10:48:35.609727Z","steps":["trace[297526063] 'process raft request' (duration: 269.119372ms)","trace[297526063] 'compare' (duration: 159.596311ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:48:35.609894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:48:35.179694Z","time spent":"430.115722ms","remote":"127.0.0.1:36676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T10:48:35.609942Z","caller":"traceutil/trace.go:171","msg":"trace[459899761] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"259.589093ms","start":"2026-04-08T10:48:35.350293Z","end":"2026-04-08T10:48:35.609882Z","steps":["trace[459899761] 'read index received' (duration: 98.466421ms)","trace[459899761] 'applied index is now lower than readState.Index' (duration: 161.117032ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:48:35.622302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.002223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T10:48:35.622351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.785499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T10:48:35.622375Z","caller":"traceutil/trace.go:171","msg":"trace[117376566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"272.084864ms","start":"2026-04-08T10:48:35.350274Z","end":"2026-04-08T10:48:35.622359Z","steps":["trace[117376566] 'agreement among raft nodes before linearized reading' (duration: 259.841188ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:35.622424Z","caller":"traceutil/trace.go:171","msg":"trace[823400404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"217.892421ms","start":"2026-04-08T10:48:35.404507Z","end":"2026-04-08T10:48:35.622399Z","steps":["trace[823400404] 'agreement among raft nodes before linearized reading' (duration: 217.759418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:49:19.285637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.363733ms","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-08T10:49:19.285841Z","caller":"traceutil/trace.go:171","msg":"trace[1102203303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1179; }","duration":"156.590448ms","start":"2026-04-08T10:49:19.129146Z","end":"2026-04-08T10:49:19.285736Z","steps":["trace[1102203303] 'range keys from in-memory index tree' (duration: 156.064178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:50:11.057356Z","caller":"traceutil/trace.go:171","msg":"trace[162278469] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"102.126107ms","start":"2026-04-08T10:50:10.955197Z","end":"2026-04-08T10:50:11.057323Z","steps":["trace[162278469] 'process raft request' (duration: 101.936144ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:50:56.483234Z","caller":"traceutil/trace.go:171","msg":"trace[1658697772] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"118.86148ms","start":"2026-04-08T10:50:56.364331Z","end":"2026-04-08T10:50:56.483193Z","steps":["trace[1658697772] 'process raft request' (duration: 118.545675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:51:02.403489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.401283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T10:51:02.403616Z","caller":"traceutil/trace.go:171","msg":"trace[1254427853] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2202; }","duration":"125.625637ms","start":"2026-04-08T10:51:02.277965Z","end":"2026-04-08T10:51:02.40359Z","steps":["trace[1254427853] 'count revisions from in-memory index tree' (duration: 125.289601ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:02.749166Z","caller":"traceutil/trace.go:171","msg":"trace[2039699305] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"172.077164ms","start":"2026-04-08T10:51:02.577048Z","end":"2026-04-08T10:51:02.749125Z","steps":["trace[2039699305] 'process raft request' (duration: 93.70111ms)","trace[2039699305] 'compare' (duration: 77.886384ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:51:54.589684Z","caller":"traceutil/trace.go:171","msg":"trace[841039292] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"398.709801ms","start":"2026-04-08T10:51:54.190943Z","end":"2026-04-08T10:51:54.589653Z","steps":["trace[841039292] 'process raft request' (duration: 398.539818ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:54.589994Z","caller":"traceutil/trace.go:171","msg":"trace[924237335] linearizableReadLoop","detail":"{readStateIndex:2760; appliedIndex:2760; }","duration":"238.858288ms","start":"2026-04-08T10:51:54.35111Z","end":"2026-04-08T10:51:54.589968Z","steps":["trace[924237335] 'read index received' (duration: 238.839887ms)","trace[924237335] 'applied index is now lower than readState.Index' (duration: 16.711µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:51:54.590044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:51:54.190918Z","time spent":"398.859153ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:51:54.590159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.04902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:51:54.590207Z","caller":"traceutil/trace.go:171","msg":"trace[1150642466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2657; }","duration":"239.148623ms","start":"2026-04-08T10:51:54.351046Z","end":"2026-04-08T10:51:54.590195Z","steps":["trace[1150642466] 'agreement among raft nodes before linearized reading' (duration: 239.065681ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:52:30.284041Z","caller":"traceutil/trace.go:171","msg":"trace[1167580326] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"118.120786ms","start":"2026-04-08T10:52:30.165891Z","end":"2026-04-08T10:52:30.284012Z","steps":["trace[1167580326] 'process raft request' (duration: 104.887955ms)","trace[1167580326] 'compare' (duration: 13.008156ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:56:31.58951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.650255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-08T10:56:31.589631Z","caller":"traceutil/trace.go:171","msg":"trace[217043271] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4790; }","duration":"129.824189ms","start":"2026-04-08T10:56:31.459779Z","end":"2026-04-08T10:56:31.589603Z","steps":["trace[217043271] 'range keys from in-memory index tree' (duration: 129.431522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:31.589667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.947381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-08T10:56:31.589855Z","caller":"traceutil/trace.go:171","msg":"trace[635214708] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4790; }","duration":"123.191657ms","start":"2026-04-08T10:56:31.466631Z","end":"2026-04-08T10:56:31.589822Z","steps":["trace[635214708] 'range keys from in-memory index tree' (duration: 122.723047ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:31.617675Z","caller":"traceutil/trace.go:171","msg":"trace[1829225228] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"144.809236ms","start":"2026-04-08T10:56:31.472839Z","end":"2026-04-08T10:56:31.617649Z","steps":["trace[1829225228] 'process raft request' (duration: 144.626083ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:31.64529Z","caller":"traceutil/trace.go:171","msg":"trace[410393123] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"172.146582ms","start":"2026-04-08T10:56:31.473109Z","end":"2026-04-08T10:56:31.645255Z","steps":["trace[410393123] 'process raft request' (duration: 171.904407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:44.296655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.063479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:56:44.296779Z","caller":"traceutil/trace.go:171","msg":"trace[1224396642] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:5121; }","duration":"212.258883ms","start":"2026-04-08T10:56:44.0845Z","end":"2026-04-08T10:56:44.296759Z","steps":["trace[1224396642] 'count revisions from in-memory index tree' (duration: 211.974878ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:44.888059Z","caller":"traceutil/trace.go:171","msg":"trace[120148265] transaction","detail":"{read_only:false; response_revision:5126; number_of_response:1; }","duration":"145.205712ms","start":"2026-04-08T10:56:44.742817Z","end":"2026-04-08T10:56:44.888023Z","steps":["trace[120148265] 'process raft request' (duration: 145.004939ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:45.090044Z","caller":"traceutil/trace.go:171","msg":"trace[1424498594] linearizableReadLoop","detail":"{readStateIndex:5322; appliedIndex:5320; }","duration":"309.675083ms","start":"2026-04-08T10:56:44.780335Z","end":"2026-04-08T10:56:45.09001Z","steps":["trace[1424498594] 'read index received' (duration: 107.606778ms)","trace[1424498594] 'applied index is now lower than readState.Index' (duration: 202.067125ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:45.09017Z","caller":"traceutil/trace.go:171","msg":"trace[197698043] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"344.807223ms","start":"2026-04-08T10:56:44.7453Z","end":"2026-04-08T10:56:45.090107Z","steps":["trace[197698043] 'process raft request' (duration: 344.513917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:45.090399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:44.745292Z","time spent":"344.991456ms","remote":"127.0.0.1:36330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3700,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:56:45.090686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.307335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:56:45.090952Z","caller":"traceutil/trace.go:171","msg":"trace[419476720] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:5127; }","duration":"310.504178ms","start":"2026-04-08T10:56:44.780306Z","end":"2026-04-08T10:56:45.09081Z","steps":["trace[419476720] 'agreement among raft nodes before linearized reading' (duration: 309.867977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:45.091048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:44.78019Z","time spent":"310.832934ms","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-04-08T10:56:45.107594Z","caller":"traceutil/trace.go:171","msg":"trace[443844416] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"213.657479ms","start":"2026-04-08T10:56:44.893903Z","end":"2026-04-08T10:56:45.107561Z","steps":["trace[443844416] 'process raft request' (duration: 213.431055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:45.107781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.565547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-025299a6-9eeb-4152-9476-c2e46a5db556\" ","response":"range_response_count:1 size:3715"} {"level":"warn","ts":"2026-04-08T10:56:45.107776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.057052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T10:56:45.107869Z","caller":"traceutil/trace.go:171","msg":"trace[631891162] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-025299a6-9eeb-4152-9476-c2e46a5db556; range_end:; response_count:1; response_revision:5128; }","duration":"298.73978ms","start":"2026-04-08T10:56:44.80911Z","end":"2026-04-08T10:56:45.10785Z","steps":["trace[631891162] 'agreement among raft nodes before linearized reading' (duration: 298.570797ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:45.107889Z","caller":"traceutil/trace.go:171","msg":"trace[535713107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5128; }","duration":"282.241415ms","start":"2026-04-08T10:56:44.825626Z","end":"2026-04-08T10:56:45.107867Z","steps":["trace[535713107] 'agreement among raft nodes before linearized reading' (duration: 281.93575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:45.107795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.690995ms","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-08T10:56:45.108009Z","caller":"traceutil/trace.go:171","msg":"trace[996293868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5128; }","duration":"275.932039ms","start":"2026-04-08T10:56:44.832042Z","end":"2026-04-08T10:56:45.107974Z","steps":["trace[996293868] 'agreement among raft nodes before linearized reading' (duration: 275.475831ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:47.286272Z","caller":"traceutil/trace.go:171","msg":"trace[835741366] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"109.700113ms","start":"2026-04-08T10:56:47.176533Z","end":"2026-04-08T10:56:47.286233Z","steps":["trace[835741366] 'process raft request' (duration: 40.7982ms)","trace[835741366] 'compare' (duration: 68.722239ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:48.936499Z","caller":"traceutil/trace.go:171","msg":"trace[1161294006] linearizableReadLoop","detail":"{readStateIndex:5449; appliedIndex:5447; }","duration":"103.974207ms","start":"2026-04-08T10:56:48.83249Z","end":"2026-04-08T10:56:48.936464Z","steps":["trace[1161294006] 'read index received' (duration: 102.109561ms)","trace[1161294006] 'applied index is now lower than readState.Index' (duration: 1.863076ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:48.936662Z","caller":"traceutil/trace.go:171","msg":"trace[625649318] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"143.197917ms","start":"2026-04-08T10:56:48.793454Z","end":"2026-04-08T10:56:48.936652Z","steps":["trace[625649318] 'process raft request' (duration: 141.306452ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:48.937116Z","caller":"traceutil/trace.go:171","msg":"trace[1440710600] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"134.188199ms","start":"2026-04-08T10:56:48.802919Z","end":"2026-04-08T10:56:48.937107Z","steps":["trace[1440710600] 'process raft request' (duration: 133.453826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:48.937242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.702361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:56:48.937293Z","caller":"traceutil/trace.go:171","msg":"trace[1141977422] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:5247; }","duration":"104.830782ms","start":"2026-04-08T10:56:48.832449Z","end":"2026-04-08T10:56:48.93728Z","steps":["trace[1141977422] 'agreement among raft nodes before linearized reading' (duration: 104.68799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:54.529454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.651017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:56:54.52969Z","caller":"traceutil/trace.go:171","msg":"trace[564846933] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"182.63692ms","start":"2026-04-08T10:56:54.347037Z","end":"2026-04-08T10:56:54.529674Z","steps":["trace[564846933] 'process raft request' (duration: 79.680808ms)","trace[564846933] 'compare' (duration: 102.373701ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:54.529858Z","caller":"traceutil/trace.go:171","msg":"trace[471606169] linearizableReadLoop","detail":"{readStateIndex:5546; appliedIndex:5545; }","duration":"178.673226ms","start":"2026-04-08T10:56:54.351178Z","end":"2026-04-08T10:56:54.529851Z","steps":["trace[471606169] 'read index received' (duration: 14.337958ms)","trace[471606169] 'applied index is now lower than readState.Index' (duration: 164.334498ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:54.529913Z","caller":"traceutil/trace.go:171","msg":"trace[2089163880] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"158.751744ms","start":"2026-04-08T10:56:54.371136Z","end":"2026-04-08T10:56:54.529888Z","steps":["trace[2089163880] 'process raft request' (duration: 158.672533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:54.529993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.828289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:56:54.530012Z","caller":"traceutil/trace.go:171","msg":"trace[270664940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5344; }","duration":"178.89707ms","start":"2026-04-08T10:56:54.35111Z","end":"2026-04-08T10:56:54.530007Z","steps":["trace[270664940] 'agreement among raft nodes before linearized reading' (duration: 178.816689ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:54.530152Z","caller":"traceutil/trace.go:171","msg":"trace[1609123891] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"159.291413ms","start":"2026-04-08T10:56:54.370849Z","end":"2026-04-08T10:56:54.530141Z","steps":["trace[1609123891] 'process raft request' (duration: 158.705132ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:54.755191Z","caller":"traceutil/trace.go:171","msg":"trace[503777668] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"219.565359ms","start":"2026-04-08T10:56:54.535588Z","end":"2026-04-08T10:56:54.755154Z","steps":["trace[503777668] 'process raft request' (duration: 133.042093ms)","trace[503777668] 'compare' (duration: 86.28362ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:03.534283Z","caller":"traceutil/trace.go:171","msg":"trace[1474663118] linearizableReadLoop","detail":"{readStateIndex:5694; appliedIndex:5693; }","duration":"204.221802ms","start":"2026-04-08T10:57:03.330024Z","end":"2026-04-08T10:57:03.534246Z","steps":["trace[1474663118] 'read index received' (duration: 204.10519ms)","trace[1474663118] 'applied index is now lower than readState.Index' (duration: 115.692µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:03.534402Z","caller":"traceutil/trace.go:171","msg":"trace[500576522] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"204.801203ms","start":"2026-04-08T10:57:03.329572Z","end":"2026-04-08T10:57:03.534373Z","steps":["trace[500576522] 'process raft request' (duration: 204.486237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:03.53483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.773842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80096"} {"level":"info","ts":"2026-04-08T10:57:03.534987Z","caller":"traceutil/trace.go:171","msg":"trace[2116805297] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5488; }","duration":"205.004216ms","start":"2026-04-08T10:57:03.329954Z","end":"2026-04-08T10:57:03.534958Z","steps":["trace[2116805297] 'agreement among raft nodes before linearized reading' (duration: 204.430756ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:03.801151Z","caller":"traceutil/trace.go:171","msg":"trace[675989306] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"470.021533ms","start":"2026-04-08T10:57:03.331095Z","end":"2026-04-08T10:57:03.801117Z","steps":["trace[675989306] 'process raft request' (duration: 453.874212ms)","trace[675989306] 'compare' (duration: 15.908647ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:57:03.801362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:57:03.33108Z","time spent":"470.171426ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:57:03.80156Z","caller":"traceutil/trace.go:171","msg":"trace[1569217667] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"438.165159ms","start":"2026-04-08T10:57:03.363372Z","end":"2026-04-08T10:57:03.801537Z","steps":["trace[1569217667] 'process raft request' (duration: 437.687329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:03.801793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:57:03.363332Z","time spent":"438.348762ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:57:03.801815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.206956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:57:03.801946Z","caller":"traceutil/trace.go:171","msg":"trace[729083834] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5490; }","duration":"404.42453ms","start":"2026-04-08T10:57:03.397492Z","end":"2026-04-08T10:57:03.801916Z","steps":["trace[729083834] 'agreement among raft nodes before linearized reading' (duration: 404.180665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:03.802035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:57:03.397439Z","time spent":"404.583413ms","remote":"127.0.0.1:47292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-08T10:57:03.802311Z","caller":"traceutil/trace.go:171","msg":"trace[2066369368] linearizableReadLoop","detail":"{readStateIndex:5696; appliedIndex:5694; }","duration":"267.100916ms","start":"2026-04-08T10:57:03.534376Z","end":"2026-04-08T10:57:03.801477Z","steps":["trace[2066369368] 'read index received' (duration: 250.576357ms)","trace[2066369368] 'applied index is now lower than readState.Index' (duration: 16.522559ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:06.260324Z","caller":"traceutil/trace.go:171","msg":"trace[31437229] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"185.005344ms","start":"2026-04-08T10:57:06.075263Z","end":"2026-04-08T10:57:06.260269Z","steps":["trace[31437229] 'process raft request' (duration: 112.625732ms)","trace[31437229] 'compare' (duration: 72.074886ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:07.088448Z","caller":"traceutil/trace.go:171","msg":"trace[859906330] linearizableReadLoop","detail":"{readStateIndex:5735; appliedIndex:5734; }","duration":"119.44199ms","start":"2026-04-08T10:57:06.968974Z","end":"2026-04-08T10:57:07.088416Z","steps":["trace[859906330] 'read index received' (duration: 42.584335ms)","trace[859906330] 'applied index is now lower than readState.Index' (duration: 76.856535ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:07.088487Z","caller":"traceutil/trace.go:171","msg":"trace[1544316142] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"123.684958ms","start":"2026-04-08T10:57:06.96476Z","end":"2026-04-08T10:57:07.088445Z","steps":["trace[1544316142] 'process raft request' (duration: 47.334223ms)","trace[1544316142] 'compare' (duration: 76.102121ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:57:07.088739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.471629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T10:57:07.088782Z","caller":"traceutil/trace.go:171","msg":"trace[220187283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5528; }","duration":"105.593251ms","start":"2026-04-08T10:57:06.983178Z","end":"2026-04-08T10:57:07.088771Z","steps":["trace[220187283] 'agreement among raft nodes before linearized reading' (duration: 105.423488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:07.088806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.783316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:9223"} {"level":"info","ts":"2026-04-08T10:57:07.088922Z","caller":"traceutil/trace.go:171","msg":"trace[132616635] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5528; }","duration":"119.96009ms","start":"2026-04-08T10:57:06.968934Z","end":"2026-04-08T10:57:07.088894Z","steps":["trace[132616635] 'agreement among raft nodes before linearized reading' (duration: 119.592942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:09.332451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.689257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T10:57:09.33257Z","caller":"traceutil/trace.go:171","msg":"trace[923353363] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:5562; }","duration":"125.914761ms","start":"2026-04-08T10:57:09.20663Z","end":"2026-04-08T10:57:09.332545Z","steps":["trace[923353363] 'count revisions from in-memory index tree' (duration: 125.558614ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:18.288008Z","caller":"traceutil/trace.go:171","msg":"trace[1833115526] linearizableReadLoop","detail":"{readStateIndex:5898; appliedIndex:5897; }","duration":"263.429618ms","start":"2026-04-08T10:57:18.024553Z","end":"2026-04-08T10:57:18.287983Z","steps":["trace[1833115526] 'read index received' (duration: 263.273555ms)","trace[1833115526] 'applied index is now lower than readState.Index' (duration: 154.953µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:18.288174Z","caller":"traceutil/trace.go:171","msg":"trace[1752614662] transaction","detail":"{read_only:false; response_revision:5686; number_of_response:1; }","duration":"391.647111ms","start":"2026-04-08T10:57:17.896508Z","end":"2026-04-08T10:57:18.288155Z","steps":["trace[1752614662] 'process raft request' (duration: 391.296824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:18.288334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:57:17.896471Z","time spent":"391.744703ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:57:18.288621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.042489ms","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-08T10:57:18.288772Z","caller":"traceutil/trace.go:171","msg":"trace[918701002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5686; }","duration":"264.230213ms","start":"2026-04-08T10:57:18.024486Z","end":"2026-04-08T10:57:18.288716Z","steps":["trace[918701002] 'agreement among raft nodes before linearized reading' (duration: 263.815654ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:18.297565Z","caller":"traceutil/trace.go:171","msg":"trace[1062541156] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"171.251447ms","start":"2026-04-08T10:57:18.126284Z","end":"2026-04-08T10:57:18.297535Z","steps":["trace[1062541156] 'process raft request' (duration: 171.086284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:57:18.297605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.413244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-08T10:57:18.29781Z","caller":"traceutil/trace.go:171","msg":"trace[1633927031] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5687; }","duration":"175.650829ms","start":"2026-04-08T10:57:18.122145Z","end":"2026-04-08T10:57:18.297796Z","steps":["trace[1633927031] 'agreement among raft nodes before linearized reading' (duration: 175.310333ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:18.460149Z","caller":"traceutil/trace.go:171","msg":"trace[1994265213] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"150.300495ms","start":"2026-04-08T10:57:18.309812Z","end":"2026-04-08T10:57:18.460113Z","steps":["trace[1994265213] 'process raft request' (duration: 144.882834ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:18.735146Z","caller":"traceutil/trace.go:171","msg":"trace[94811748] transaction","detail":"{read_only:false; response_revision:5694; number_of_response:1; }","duration":"109.655277ms","start":"2026-04-08T10:57:18.625437Z","end":"2026-04-08T10:57:18.735092Z","steps":["trace[94811748] 'process raft request' (duration: 51.969501ms)","trace[94811748] 'compare' (duration: 57.455392ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:57.195648Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3021} {"level":"info","ts":"2026-04-08T10:57:57.286904Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3021,"took":"88.321769ms","hash":2848385122,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":31272960,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-08T10:57:57.286987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2848385122,"revision":3021,"compact-revision":-1} {"level":"info","ts":"2026-04-08T10:58:08.709412Z","caller":"traceutil/trace.go:171","msg":"trace[1840170075] transaction","detail":"{read_only:false; response_revision:6115; number_of_response:1; }","duration":"128.563561ms","start":"2026-04-08T10:58:08.58081Z","end":"2026-04-08T10:58:08.709374Z","steps":["trace[1840170075] 'process raft request' (duration: 87.598266ms)","trace[1840170075] 'compare' (duration: 40.635909ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:02:57.202276Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6043} {"level":"info","ts":"2026-04-08T11:02:57.320321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6043,"took":"115.658045ms","hash":2160777008,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":21684224,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T11:02:57.320411Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2160777008,"revision":6043,"compact-revision":3021} {"level":"info","ts":"2026-04-08T11:03:29.736806Z","caller":"traceutil/trace.go:171","msg":"trace[98146977] transaction","detail":"{read_only:false; response_revision:8467; number_of_response:1; }","duration":"178.251703ms","start":"2026-04-08T11:03:29.558533Z","end":"2026-04-08T11:03:29.736785Z","steps":["trace[98146977] 'process raft request' (duration: 178.10814ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:29.98655Z","caller":"traceutil/trace.go:171","msg":"trace[889490708] transaction","detail":"{read_only:false; response_revision:8468; number_of_response:1; }","duration":"236.777024ms","start":"2026-04-08T11:03:29.749742Z","end":"2026-04-08T11:03:29.986519Z","steps":["trace[889490708] 'process raft request' (duration: 236.5513ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:29.99527Z","caller":"traceutil/trace.go:171","msg":"trace[175050158] transaction","detail":"{read_only:false; response_revision:8469; number_of_response:1; }","duration":"149.420585ms","start":"2026-04-08T11:03:29.845822Z","end":"2026-04-08T11:03:29.995243Z","steps":["trace[175050158] 'process raft request' (duration: 149.255172ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:41.191567Z","caller":"traceutil/trace.go:171","msg":"trace[1273995389] transaction","detail":"{read_only:false; response_revision:8528; number_of_response:1; }","duration":"153.672975ms","start":"2026-04-08T11:03:41.037847Z","end":"2026-04-08T11:03:41.19152Z","steps":["trace[1273995389] 'process raft request' (duration: 122.015545ms)","trace[1273995389] 'compare' (duration: 31.389195ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:03:41.191589Z","caller":"traceutil/trace.go:171","msg":"trace[1630098497] linearizableReadLoop","detail":"{readStateIndex:8832; appliedIndex:8831; }","duration":"120.71604ms","start":"2026-04-08T11:03:41.070835Z","end":"2026-04-08T11:03:41.191551Z","steps":["trace[1630098497] 'read index received' (duration: 89.016678ms)","trace[1630098497] 'applied index is now lower than readState.Index' (duration: 31.693072ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T11:03:41.191881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.984214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T11:03:41.192021Z","caller":"traceutil/trace.go:171","msg":"trace[1543515589] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8529; }","duration":"121.22246ms","start":"2026-04-08T11:03:41.070766Z","end":"2026-04-08T11:03:41.191989Z","steps":["trace[1543515589] 'agreement among raft nodes before linearized reading' (duration: 120.926814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:41.599893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.985104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T11:03:41.600006Z","caller":"traceutil/trace.go:171","msg":"trace[504599765] linearizableReadLoop","detail":"{readStateIndex:8835; appliedIndex:8834; }","duration":"316.043631ms","start":"2026-04-08T11:03:41.283945Z","end":"2026-04-08T11:03:41.599988Z","steps":["trace[504599765] 'read index received' (duration: 24.780981ms)","trace[504599765] 'applied index is now lower than readState.Index' (duration: 291.26124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T11:03:41.600076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.131443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T11:03:41.600115Z","caller":"traceutil/trace.go:171","msg":"trace[2052664284] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8531; }","duration":"316.188775ms","start":"2026-04-08T11:03:41.283908Z","end":"2026-04-08T11:03:41.600097Z","steps":["trace[2052664284] 'agreement among raft nodes before linearized reading' (duration: 316.128873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:41.600188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:03:41.283878Z","time spent":"316.296216ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"info","ts":"2026-04-08T11:03:41.600596Z","caller":"traceutil/trace.go:171","msg":"trace[144848429] transaction","detail":"{read_only:false; response_revision:8531; number_of_response:1; }","duration":"323.633633ms","start":"2026-04-08T11:03:41.276642Z","end":"2026-04-08T11:03:41.600276Z","steps":["trace[144848429] 'process raft request' (duration: 32.16805ms)","trace[144848429] 'compare' (duration: 290.566056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T11:03:41.600885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:03:41.276625Z","time spent":"324.124971ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T11:04:24.056107Z","caller":"traceutil/trace.go:171","msg":"trace[11416353] transaction","detail":"{read_only:false; response_revision:8852; number_of_response:1; }","duration":"145.427291ms","start":"2026-04-08T11:04:23.910635Z","end":"2026-04-08T11:04:24.056062Z","steps":["trace[11416353] 'process raft request' (duration: 145.242048ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:04:25.438982Z","caller":"traceutil/trace.go:171","msg":"trace[1243974370] transaction","detail":"{read_only:false; response_revision:8864; number_of_response:1; }","duration":"119.986136ms","start":"2026-04-08T11:04:25.318957Z","end":"2026-04-08T11:04:25.438943Z","steps":["trace[1243974370] 'process raft request' (duration: 119.392546ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:04:39.117327Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002461.wal"} {"level":"warn","ts":"2026-04-08T11:05:42.34796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.095894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T11:05:42.348118Z","caller":"traceutil/trace.go:171","msg":"trace[1669130206] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9612; }","duration":"153.326789ms","start":"2026-04-08T11:05:42.194757Z","end":"2026-04-08T11:05:42.348084Z","steps":["trace[1669130206] 'range keys from in-memory index tree' (duration: 152.819478ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:05:47.477759Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d660142aa1b7ce9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T11:05:47.482783Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T11:05:47.482901Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T11:07:57.213231Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8121} {"level":"info","ts":"2026-04-08T11:07:57.277386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8121,"took":"61.85777ms","hash":3877020052,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":29024256,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T11:07:57.277457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3877020052,"revision":8121,"compact-revision":6043} {"level":"info","ts":"2026-04-08T11:12:57.218048Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10642} {"level":"info","ts":"2026-04-08T11:12:57.300874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10642,"took":"80.275838ms","hash":2518450436,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":21917696,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T11:12:57.300941Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2518450436,"revision":10642,"compact-revision":8121}